2019-07-25T00:02:19.058Z,1564012939.058 [Supervisor](DEBUG): Initializing supervisor. 2019-07-25T00:02:19.061Z,1564012939.061 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-07-25T00:02:19.061Z,1564012939.061 [SyncHandler](INFO): Protected caller Thread ID is 7511 2019-07-25T00:02:19.062Z,1564012939.062 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-07-25T00:02:19.063Z,1564012939.063 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-07-25T00:02:19.063Z,1564012939.063 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7512 2019-07-25T00:02:19.066Z,1564012939.066 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-07-25T00:02:19.077Z,1564012939.077 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-07-25T00:02:19.078Z,1564012939.078 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-07-25T00:02:19.079Z,1564012939.079 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7513 2019-07-25T00:02:19.080Z,1564012939.080 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-07-25T00:02:19.081Z,1564012939.081 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-07-25T00:02:19.081Z,1564012939.081 [logger ThreadHandler](INFO): Protected caller Thread ID is 7514 2019-07-25T00:02:19.083Z,1564012939.083 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-07-25T00:02:19.083Z,1564012939.083 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-07-25T00:02:19.085Z,1564012939.085 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-07-25T00:02:19.178Z,1564012939.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-07-25T00:02:19.179Z,1564012939.179 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-07-25T00:02:19.378Z,1564012939.378 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-07-25T00:02:19.378Z,1564012939.378 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-07-25T00:02:19.513Z,1564012939.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-07-25T00:02:19.514Z,1564012939.514 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-07-25T00:02:20.076Z,1564012940.076 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-07-25T00:02:20.076Z,1564012940.076 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-07-25T00:02:20.518Z,1564012940.518 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-07-25T00:02:20.518Z,1564012940.518 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-07-25T00:02:20.992Z,1564012940.992 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-07-25T00:02:20.993Z,1564012940.993 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-07-25T00:02:21.297Z,1564012941.297 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-07-25T00:02:21.298Z,1564012941.298 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-07-25T00:02:21.630Z,1564012941.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-07-25T00:02:21.631Z,1564012941.631 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-07-25T00:02:22.055Z,1564012942.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-07-25T00:02:22.055Z,1564012942.055 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-07-25T00:02:22.204Z,1564012942.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-07-25T00:02:22.205Z,1564012942.205 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-07-25T00:02:22.308Z,1564012942.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-07-25T00:02:22.309Z,1564012942.309 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-07-25T00:02:22.388Z,1564012942.388 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-07-25T00:02:22.487Z,1564012942.487 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-07-25T00:02:22.488Z,1564012942.488 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-07-25T00:02:22.684Z,1564012942.684 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-07-25T00:02:22.684Z,1564012942.684 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-07-25T00:02:22.896Z,1564012942.896 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-07-25T00:02:22.899Z,1564012942.899 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2019-07-25T00:02:22.899Z,1564012942.899 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2019-07-25T00:02:22.982Z,1564012942.982 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2019-07-25T00:02:23.210Z,1564012943.210 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-07-25T00:02:23.211Z,1564012943.211 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2019-07-25T00:02:23.307Z,1564012943.307 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2019-07-25T00:02:23.479Z,1564012943.479 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2019-07-25T00:02:23.693Z,1564012943.693 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2019-07-25T00:02:23.815Z,1564012943.815 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2019-07-25T00:02:24.152Z,1564012944.152 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2019-07-25T00:02:24.394Z,1564012944.394 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2019-07-25T00:02:24.811Z,1564012944.811 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2019-07-25T00:02:24.923Z,1564012944.923 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2019-07-25T00:02:25.021Z,1564012945.021 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-07-25T00:02:25.027Z,1564012945.027 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-07-25T00:02:25.124Z,1564012945.124 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-07-25T00:02:25.125Z,1564012945.125 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-07-25T00:02:25.232Z,1564012945.232 [BuoyancyServo] Loaded 2019-07-25T00:02:25.233Z,1564012945.233 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-07-25T00:02:25.248Z,1564012945.248 [ElevatorServo] Loaded 2019-07-25T00:02:25.248Z,1564012945.248 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-07-25T00:02:25.262Z,1564012945.262 [MassServo] Loaded 2019-07-25T00:02:25.262Z,1564012945.262 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-07-25T00:02:25.277Z,1564012945.277 [RudderServo] Loaded 2019-07-25T00:02:25.278Z,1564012945.278 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-07-25T00:02:25.292Z,1564012945.292 [ThrusterServo] Loaded 2019-07-25T00:02:25.292Z,1564012945.292 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-07-25T00:02:25.293Z,1564012945.293 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-07-25T00:02:25.293Z,1564012945.293 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-07-25T00:02:25.428Z,1564012945.428 [SBIT](DEBUG): Construct Startup Built In Test. 2019-07-25T00:02:25.457Z,1564012945.457 [SBIT] Loaded 2019-07-25T00:02:25.457Z,1564012945.457 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-07-25T00:02:25.458Z,1564012945.458 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-07-25T00:02:25.485Z,1564012945.485 [IBIT] Loaded 2019-07-25T00:02:25.485Z,1564012945.485 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-07-25T00:02:25.488Z,1564012945.488 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-07-25T00:02:25.875Z,1564012945.875 [CBIT] Loaded 2019-07-25T00:02:25.875Z,1564012945.875 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-07-25T00:02:25.875Z,1564012945.875 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-07-25T00:02:25.876Z,1564012945.876 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-07-25T00:02:26.076Z,1564012946.076 [Aanderaa_O2] Loaded 2019-07-25T00:02:26.076Z,1564012946.076 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2019-07-25T00:02:26.095Z,1564012946.095 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2019-07-25T00:02:26.100Z,1564012946.100 [CTD_Seabird](INFO): created writer for : sea_water_density 2019-07-25T00:02:26.114Z,1564012946.114 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2019-07-25T00:02:26.119Z,1564012946.119 [CTD_Seabird](INFO): created writer for : depth 2019-07-25T00:02:26.119Z,1564012946.119 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2019-07-25T00:02:26.124Z,1564012946.124 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2019-07-25T00:02:26.125Z,1564012946.125 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2019-07-25T00:02:26.158Z,1564012946.158 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2019-07-25T00:02:26.159Z,1564012946.159 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2019-07-25T00:02:26.164Z,1564012946.164 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2019-07-25T00:02:26.165Z,1564012946.165 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2019-07-25T00:02:26.175Z,1564012946.175 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2019-07-25T00:02:26.176Z,1564012946.176 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2019-07-25T00:02:26.181Z,1564012946.181 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2019-07-25T00:02:26.206Z,1564012946.206 [CTD_Seabird] Loaded 2019-07-25T00:02:26.207Z,1564012946.207 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2019-07-25T00:02:26.208Z,1564012946.208 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4066A4E0 2019-07-25T00:02:26.208Z,1564012946.208 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7595 2019-07-25T00:02:26.238Z,1564012946.238 [ESPComponent] Loaded 2019-07-25T00:02:26.238Z,1564012946.238 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2019-07-25T00:02:26.252Z,1564012946.252 [PAR_Licor] Loaded 2019-07-25T00:02:26.253Z,1564012946.253 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2019-07-25T00:02:26.300Z,1564012946.300 [WetLabsBB2FL] Loaded 2019-07-25T00:02:26.300Z,1564012946.300 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2019-07-25T00:02:26.301Z,1564012946.301 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4069A4E0 2019-07-25T00:02:26.302Z,1564012946.302 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7596 2019-07-25T00:02:26.302Z,1564012946.302 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-07-25T00:02:26.303Z,1564012946.303 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-07-25T00:02:26.344Z,1564012946.344 [DepthRateCalculator] Loaded 2019-07-25T00:02:26.344Z,1564012946.344 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-07-25T00:02:26.351Z,1564012946.351 [PitchRateCalculator] Loaded 2019-07-25T00:02:26.351Z,1564012946.351 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-07-25T00:02:26.368Z,1564012946.368 [SpeedCalculator] Loaded 2019-07-25T00:02:26.369Z,1564012946.369 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-07-25T00:02:26.389Z,1564012946.389 [TempGradientCalculator] Loaded 2019-07-25T00:02:26.390Z,1564012946.390 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-07-25T00:02:26.395Z,1564012946.395 [YawRateCalculator] Loaded 2019-07-25T00:02:26.396Z,1564012946.396 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-07-25T00:02:26.428Z,1564012946.428 [ElevatorOffsetCalculator] Loaded 2019-07-25T00:02:26.428Z,1564012946.428 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-07-25T00:02:26.428Z,1564012946.428 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-07-25T00:02:26.429Z,1564012946.429 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-07-25T00:02:26.461Z,1564012946.461 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-07-25T00:02:26.461Z,1564012946.461 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-07-25T00:02:26.563Z,1564012946.563 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-07-25T00:02:26.564Z,1564012946.564 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-07-25T00:02:26.585Z,1564012946.585 [NavChart] Loaded 2019-07-25T00:02:26.585Z,1564012946.585 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-07-25T00:02:26.589Z,1564012946.589 [UniversalFixResidualReporter] Loaded 2019-07-25T00:02:26.590Z,1564012946.590 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-07-25T00:02:26.590Z,1564012946.590 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-07-25T00:02:26.591Z,1564012946.591 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-07-25T00:02:26.939Z,1564012946.939 [AHRS_M2] Loaded 2019-07-25T00:02:26.939Z,1564012946.939 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2019-07-25T00:02:27.012Z,1564012947.012 [DataOverHttps] Loaded 2019-07-25T00:02:27.012Z,1564012947.012 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-07-25T00:02:27.013Z,1564012947.013 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409734E0 2019-07-25T00:02:27.014Z,1564012947.014 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7597 2019-07-25T00:02:27.027Z,1564012947.027 [Depth_Keller] Loaded 2019-07-25T00:02:27.027Z,1564012947.027 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-07-25T00:02:27.032Z,1564012947.032 [DropWeight] Loaded 2019-07-25T00:02:27.032Z,1564012947.032 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2019-07-25T00:02:27.161Z,1564012947.161 [DVL_micro] Loaded 2019-07-25T00:02:27.162Z,1564012947.162 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2019-07-25T00:02:27.251Z,1564012947.251 [NAL9602] Loaded 2019-07-25T00:02:27.251Z,1564012947.251 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-07-25T00:02:27.256Z,1564012947.256 [Onboard] Loaded 2019-07-25T00:02:27.256Z,1564012947.256 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-07-25T00:02:27.260Z,1564012947.260 [Radio_Surface] Loaded 2019-07-25T00:02:27.260Z,1564012947.260 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-07-25T00:02:27.261Z,1564012947.261 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409A34E0 2019-07-25T00:02:27.261Z,1564012947.261 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7598 2019-07-25T00:02:27.388Z,1564012947.388 [DAT] Loaded 2019-07-25T00:02:27.388Z,1564012947.388 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2019-07-25T00:02:28.668Z,1564012948.668 [BPC1] Loaded 2019-07-25T00:02:28.668Z,1564012948.668 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-07-25T00:02:28.669Z,1564012948.669 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-07-25T00:02:28.669Z,1564012948.669 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-07-25T00:02:28.739Z,1564012948.739 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-07-25T00:02:28.740Z,1564012948.740 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-07-25T00:02:28.808Z,1564012948.808 [VerticalControl](DEBUG): Construct VerticalControl. 2019-07-25T00:02:28.890Z,1564012948.890 [VerticalControl] Loaded 2019-07-25T00:02:28.891Z,1564012948.891 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-07-25T00:02:28.891Z,1564012948.891 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-07-25T00:02:28.949Z,1564012948.949 [HorizontalControl] Loaded 2019-07-25T00:02:28.949Z,1564012948.949 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-07-25T00:02:28.950Z,1564012948.950 [SpeedControl](DEBUG): Construct SpeedControl. 2019-07-25T00:02:28.952Z,1564012948.952 [SpeedControl] Loaded 2019-07-25T00:02:28.952Z,1564012948.952 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-07-25T00:02:28.953Z,1564012948.953 [LoopControl](DEBUG): Construct LoopControl. 2019-07-25T00:02:28.953Z,1564012948.953 [LoopControl] Loaded 2019-07-25T00:02:28.953Z,1564012948.953 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-07-25T00:02:28.954Z,1564012948.954 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-07-25T00:02:28.954Z,1564012948.954 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-07-25T00:02:29.002Z,1564012949.002 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-07-25T00:02:29.002Z,1564012949.002 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-07-25T00:02:29.457Z,1564012949.457 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-07-25T00:02:29.461Z,1564012949.461 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-07-25T00:02:29.462Z,1564012949.462 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-07-25T00:02:29.468Z,1564012949.468 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-07-25T00:02:29.469Z,1564012949.469 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ADE4E0 2019-07-25T00:02:29.470Z,1564012949.470 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7599 2019-07-25T00:02:29.475Z,1564012949.475 [Supervisor](INFO): Main Thread ID is 7510 2019-07-25T00:02:29.475Z,1564012949.475 [Supervisor](DEBUG): Running supervisor. 2019-07-25T00:02:29.475Z,1564012949.475 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7600 2019-07-25T00:02:29.478Z,1564012949.478 [controlThread ThreadHandler](INFO): Handler Thread ID is 7601 2019-07-25T00:02:29.478Z,1564012949.478 [controlThread](DEBUG): Initializing ControlThread 2019-07-25T00:02:29.480Z,1564012949.480 [SBIT](INFO): Initialize SBIT Component. 2019-07-25T00:02:29.480Z,1564012949.480 [SBIT](IMPORTANT): git: 2019-07-23 2019-07-25T00:02:29.481Z,1564012949.481 [SBIT](INFO): git hash: 66f82fd8c0ed4c5b011038c11738fd4b7b507f51 2019-07-25T00:02:29.481Z,1564012949.481 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-07-25T00:02:29.482Z,1564012949.482 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 2019-07-25T00:02:29.484Z,1564012949.484 [SBIT](INFO): Beginning SBIT in 139.000000 seconds. 2019-07-25T00:02:29.484Z,1564012949.484 [IBIT](INFO): Initialize IBIT Component. 2019-07-25T00:02:29.485Z,1564012949.485 [CBIT](DEBUG): Initialize CBIT Component. 2019-07-25T00:02:29.486Z,1564012949.486 [logger ThreadHandler](INFO): Handler Thread ID is 7602 2019-07-25T00:02:29.498Z,1564012949.498 [CBIT](DEBUG): Initialized mux pins. 2019-07-25T00:02:29.498Z,1564012949.498 [CBIT](DEBUG): Initializing the watchdog timer. 2019-07-25T00:02:29.506Z,1564012949.506 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7603 2019-07-25T00:02:29.507Z,1564012949.507 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-07-25T00:02:29.510Z,1564012949.510 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-07-25T00:02:29.512Z,1564012949.512 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7605 2019-07-25T00:02:29.513Z,1564012949.513 [WetLabsBB2FL](INFO): Powering down 2019-07-25T00:02:29.522Z,1564012949.522 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-07-25T00:02:29.522Z,1564012949.522 [CBIT](DEBUG): Initializing heartbeat. 2019-07-25T00:02:29.542Z,1564012949.542 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7606 2019-07-25T00:02:29.543Z,1564012949.543 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-07-25T00:02:29.554Z,1564012949.554 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7607 2019-07-25T00:02:29.570Z,1564012949.570 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7608 2019-07-25T00:02:29.573Z,1564012949.573 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-07-25T00:02:29.574Z,1564012949.574 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-07-25T00:02:29.574Z,1564012949.574 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-07-25T00:02:29.574Z,1564012949.574 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-07-25T00:02:29.574Z,1564012949.574 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-07-25T00:02:29.575Z,1564012949.575 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-07-25T00:02:29.575Z,1564012949.575 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-07-25T00:02:29.575Z,1564012949.575 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-07-25T00:02:29.575Z,1564012949.575 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-07-25T00:02:29.575Z,1564012949.575 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-07-25T00:02:29.576Z,1564012949.576 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-07-25T00:02:29.576Z,1564012949.576 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-07-25T00:02:29.576Z,1564012949.576 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-07-25T00:02:29.576Z,1564012949.576 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-07-25T00:02:29.576Z,1564012949.576 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-07-25T00:02:29.576Z,1564012949.576 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-07-25T00:02:29.594Z,1564012949.594 [CBIT](DEBUG): Deactivating GF circuits. 2019-07-25T00:02:29.594Z,1564012949.594 [CBIT](DEBUG): Deactivating emergency mode. 2019-07-25T00:02:29.630Z,1564012949.630 [CBIT](DEBUG): Backplane powered. 2019-07-25T00:02:29.634Z,1564012949.634 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-07-25T00:02:29.635Z,1564012949.635 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-07-25T00:02:29.635Z,1564012949.635 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-07-25T00:02:29.635Z,1564012949.635 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-07-25T00:02:29.636Z,1564012949.636 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-07-25T00:02:29.636Z,1564012949.636 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-07-25T00:02:29.637Z,1564012949.637 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-07-25T00:02:29.638Z,1564012949.638 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-07-25T00:02:29.649Z,1564012949.649 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-07-25T00:02:29.658Z,1564012949.658 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-07-25T00:02:29.659Z,1564012949.659 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-07-25T00:02:29.660Z,1564012949.660 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-07-25T00:02:29.661Z,1564012949.661 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-07-25T00:02:29.695Z,1564012949.695 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-07-25T00:02:29.742Z,1564012949.742 [MissionManager](DEBUG): 2019-07-25T00:02:29.743Z,1564012949.743 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-07-25T00:02:29.824Z,1564012949.824 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-07-25T00:02:29.825Z,1564012949.825 [Default:A.Wait](DEBUG): Construct Wait. 2019-07-25T00:02:29.827Z,1564012949.827 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-07-25T00:02:29.875Z,1564012949.875 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-07-25T00:02:29.878Z,1564012949.878 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-07-25T00:02:29.892Z,1564012949.892 [Default:E.Execute](DEBUG): Construct Execute. 2019-07-25T00:02:29.895Z,1564012949.895 [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-07-25T00:02:29.922Z,1564012949.922 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-07-25T00:02:29.958Z,1564012949.958 [Radio_Surface](INFO): Powering up 2019-07-25T00:02:29.975Z,1564012949.975 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-07-25T00:02:30.018Z,1564012950.018 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar 2019-07-25T00:02:30.042Z,1564012950.042 [DVL_micro](INFO): Initializing 2019-07-25T00:02:30.078Z,1564012950.078 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2019-07-25T00:02:30.078Z,1564012950.078 [DAT](INFO): Powering up 2019-07-25T00:02:30.078Z,1564012950.078 [DAT](DEBUG): Initializing DAT. 2019-07-25T00:02:30.142Z,1564012950.142 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-07-25T00:02:30.168Z,1564012950.168 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-07-25T00:02:30.174Z,1564012950.174 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2019-07-25T00:02:30.210Z,1564012950.210 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-07-25T00:02:30.211Z,1564012950.211 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-07-25T00:02:30.214Z,1564012950.214 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-07-25T00:02:30.215Z,1564012950.215 [MassServo](DEBUG): Initializing EZServoServo. 2019-07-25T00:02:30.227Z,1564012950.227 [MassServo](DEBUG): Initializing MassServo. 2019-07-25T00:02:30.228Z,1564012950.228 [RudderServo](DEBUG): Initializing EZServoServo. 2019-07-25T00:02:30.238Z,1564012950.238 [RudderServo](DEBUG): Initializing RudderServo. 2019-07-25T00:02:30.239Z,1564012950.239 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-07-25T00:02:30.250Z,1564012950.250 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-07-25T00:02:31.186Z,1564012951.186 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2019-07-25T00:02:31.186Z,1564012951.186 [RudderServo](FAULT): Rudder failed to initialize 2019-07-25T00:02:31.186Z,1564012951.186 [RudderServo] Communications Fault, FailCount= 1 2019-07-25T00:02:31.186Z,1564012951.186 [RudderServo](ERROR): Communications Fault 2019-07-25T00:02:31.297Z,1564012951.297 [CBIT](ERROR): Communications Fault in component: RudderServo 2019-07-25T00:02:31.495Z,1564012951.495 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-07-25T00:02:31.495Z,1564012951.495 [RudderServo](INFO): Powering down 2019-07-25T00:02:32.180Z,1564012952.180 [RudderServo](DEBUG): Initializing EZServoServo. 2019-07-25T00:02:32.299Z,1564012952.299 [RudderServo](DEBUG): Initializing RudderServo. 2019-07-25T00:02:32.303Z,1564012952.303 [CBIT](INFO): Clearing failed state for component RudderServo 2019-07-25T00:02:32.303Z,1564012952.303 [RudderServo] No Fault, FailCount= 1 2019-07-25T00:02:33.442Z,1564012953.442 [Aanderaa_O2](INFO): Powering down 2019-07-25T00:02:43.260Z,1564012963.260 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005142 2019-07-25T00:02:45.470Z,1564012965.470 [DAT](INFO): setting local address to 3 2019-07-25T00:02:45.871Z,1564012965.871 [DAT](INFO): set local address to 3 2019-07-25T00:02:57.580Z,1564012977.580 [NAL9602](INFO): Powering up NAL9602 2019-07-25T00:03:08.484Z,1564012988.484 [NAL9602](INFO): NAL9602 initialized 2019-07-25T00:03:09.302Z,1564012989.302 [NAL9602](DEBUG): Fix Requested 2019-07-25T00:03:18.603Z,1564012998.603 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:03:18.603Z,1564012998.603 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 40 111 8 146 2 3 2 2 42.7 -46.7 82.2 2 -49.7 39.2 82.2 2 42 -46 82 2 -49 39 82 2 1. 189.3 -3.0 18.4 0.005 35.0 1489 81 2019-07-25T00:03:21.839Z,1564013001.839 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:03:21.839Z,1564013001.839 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 4411 2 3 2 2 101.4 -141.5 34.5 2 -122.9 123.3 34.5 2 101 -141 34 2 -122 123 34 2 1.00 -1.58 189.3 -3.0 18.5 0.005 35.0 1489 66 2019-07-25T00:04:49.144Z,1564013089.144 [SBIT](IMPORTANT): Beginning Startup BIT 2019-07-25T00:04:49.152Z,1564013089.152 [CBIT](IMPORTANT): Beginning ground fault scan 2019-07-25T00:04:49.856Z,1564013089.856 [CommandLine](IMPORTANT): got command failComponent 2019-07-25T00:04:49.856Z,1564013089.856 [CommandLine](IMPORTANT): Failed components: 2019-07-25T00:04:49.856Z,1564013089.856 [CommandLine](IMPORTANT): No failed Components. 2019-07-25T00:05:00.146Z,1564013100.146 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.083129 CHAN A1 (24V): 0.034346 CHAN A2 (12V): -0.028912 CHAN A3 (5V): -0.055197 CHAN B0 (3.3V): -0.030442 CHAN B1 (3.15aV): -0.017110 CHAN B2 (3.15bV): -0.010951 CHAN B3 (GND): -0.033857 OPEN: 0.009049 Full Scale Calc: 4.765 mA, -1.589 mA 2019-07-25T00:05:29.770Z,1564013129.770 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-07-25T00:05:29.770Z,1564013129.770 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:05:29.791Z,1564013129.791 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:05:30.166Z,1564013130.166 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:05:30.166Z,1564013130.166 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-07-25T00:05:34.324Z,1564013134.324 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-07-25T00:05:34.324Z,1564013134.324 [DVL_micro] Data Fault, FailCount= 1 2019-07-25T00:05:34.324Z,1564013134.324 [DVL_micro](ERROR): Data Fault 2019-07-25T00:05:34.423Z,1564013134.423 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-07-25T00:05:34.798Z,1564013134.798 [DVL_micro](INFO): uninitialize:Powering down 2019-07-25T00:05:35.576Z,1564013135.576 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-07-25T00:05:35.576Z,1564013135.576 [DVL_micro] No Fault, FailCount= 1 2019-07-25T00:05:35.945Z,1564013135.945 [DVL_micro](INFO): Initializing 2019-07-25T00:05:42.460Z,1564013142.460 [SBIT](IMPORTANT): SBIT PASSED 2019-07-25T00:05:42.500Z,1564013142.500 [CommandLine](IMPORTANT): got command configSet list 2019-07-25T00:05:42.500Z,1564013142.500 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-07-25T00:05:42.501Z,1564013142.501 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count; 2019-07-25T00:05:42.501Z,1564013142.501 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpDepth=5 meter; 2019-07-25T00:05:42.501Z,1564013142.501 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=400 cubic_centimeter; 2019-07-25T00:05:42.501Z,1564013142.501 [CommandLine](IMPORTANT): VerticalControl.kiDepthBuoy=0.3 reciprocal_second; 2019-07-25T00:05:42.502Z,1564013142.502 [CommandLine](IMPORTANT): VerticalControl.massDefault=30 millimeter; 2019-07-25T00:05:42.831Z,1564013142.831 [MissionManager](IMPORTANT): Started mission Startup 2019-07-25T00:05:42.831Z,1564013142.831 [Startup] Running Loop=1 2019-07-25T00:05:42.832Z,1564013142.832 [Startup](DEBUG): Aggregate::initialize Startup 2019-07-25T00:05:42.832Z,1564013142.832 [Startup:A.GoToSurface] Running Loop=1 2019-07-25T00:05:42.832Z,1564013142.832 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-25T00:05:42.832Z,1564013142.832 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-25T00:05:42.833Z,1564013142.833 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-25T00:05:42.833Z,1564013142.833 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-25T00:05:42.833Z,1564013142.833 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-25T00:05:42.834Z,1564013142.834 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-25T00:05:42.835Z,1564013142.835 [Startup:StartupSatComms] Running Loop=1 2019-07-25T00:05:42.836Z,1564013142.836 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-07-25T00:05:42.836Z,1564013142.836 [Startup:StartupSatComms:A] Running Loop=1 2019-07-25T00:05:43.232Z,1564013143.232 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-07-25T00:06:43.014Z,1564013203.014 [Startup:StartupSatComms:A](INFO): Timed out from 2019-07-25T00:05:42.8Z 2019-07-25T00:06:43.015Z,1564013203.015 [Startup:StartupSatComms:A] Stopped 2019-07-25T00:06:43.015Z,1564013203.015 [Startup:StartupSatComms:B] Running Loop=1 2019-07-25T00:06:43.479Z,1564013203.479 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-07-25T00:06:49.273Z,1564013209.273 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190724T232310/Courier0015.lzma 2019-07-25T00:06:50.079Z,1564013210.079 [DataOverHttps](INFO): Moved sent file to Logs/20190724T232310/Courier0015.lzma.bak 2019-07-25T00:06:50.080Z,1564013210.080 [DataOverHttps](INFO): SBD MOMSN=11473341 2019-07-25T00:07:00.611Z,1564013220.611 [CommandLine](IMPORTANT): got command show stack 2019-07-25T00:07:00.611Z,1564013220.611 [CommandLine](IMPORTANT): Behavior Stack: 2019-07-25T00:07:00.611Z,1564013220.611 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface 2019-07-25T00:07:00.611Z,1564013220.611 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B 2019-07-25T00:07:01.777Z,1564013221.777 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20190724T232310/Express0016.lzma 2019-07-25T00:07:02.587Z,1564013222.587 [DataOverHttps](INFO): Moved sent file to Logs/20190724T232310/Express0016.lzma.bak 2019-07-25T00:07:02.588Z,1564013222.588 [DataOverHttps](INFO): SBD MOMSN=11473343 2019-07-25T00:07:06.180Z,1564013226.180 [CommandLine](IMPORTANT): got command show variable elevatorAngle 2019-07-25T00:07:06.299Z,1564013226.299 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleAction (radian) 2019-07-25T00:07:06.300Z,1564013226.300 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleCmd (radian) 2019-07-25T00:07:16.939Z,1564013236.939 [DataOverHttps](INFO): Sending 875 bytes from file Logs/20190725T000219/Express0001.lzma 2019-07-25T00:07:17.744Z,1564013237.744 [DataOverHttps](INFO): Moved sent file to Logs/20190725T000219/Express0001.lzma.bak 2019-07-25T00:07:17.744Z,1564013237.744 [DataOverHttps](INFO): SBD MOMSN=11473346 2019-07-25T00:07:18.194Z,1564013238.194 [Startup:StartupSatComms:B] Stopped 2019-07-25T00:07:18.195Z,1564013238.195 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-07-25T00:07:18.195Z,1564013238.195 [Startup:StartupSatComms] Stopped 2019-07-25T00:07:18.195Z,1564013238.195 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-07-25T00:07:18.196Z,1564013238.196 [Startup](INFO): Completed Startup 2019-07-25T00:07:18.196Z,1564013238.196 [MissionManager](INFO): Startup is completed. 2019-07-25T00:07:18.196Z,1564013238.196 [MissionManager](INFO): Uninitializing Mission Startup 2019-07-25T00:07:18.196Z,1564013238.196 [Startup] Stopped 2019-07-25T00:07:18.196Z,1564013238.196 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-07-25T00:07:18.196Z,1564013238.196 [Startup:A.GoToSurface] Stopped 2019-07-25T00:07:18.196Z,1564013238.196 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-25T00:07:18.577Z,1564013238.577 [MissionManager](IMPORTANT): Started mission Default 2019-07-25T00:07:18.577Z,1564013238.577 [Default] Running Loop=1 2019-07-25T00:07:18.577Z,1564013238.577 [Default](DEBUG): Aggregate::initialize Default 2019-07-25T00:07:18.577Z,1564013238.577 [Default:B.GoToSurface] Running Loop=1 2019-07-25T00:07:18.577Z,1564013238.577 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-25T00:07:18.578Z,1564013238.578 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-25T00:07:18.578Z,1564013238.578 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-25T00:07:18.579Z,1564013238.579 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-25T00:07:18.579Z,1564013238.579 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-25T00:07:18.579Z,1564013238.579 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-25T00:07:18.580Z,1564013238.580 [Default:A.Wait] Running Loop=1 2019-07-25T00:07:18.580Z,1564013238.580 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-07-25T00:07:31.924Z,1564013251.924 [Default:A.Wait](INFO): Done Waiting. 2019-07-25T00:07:31.924Z,1564013251.924 [Default:A.Wait] Stopped 2019-07-25T00:07:31.924Z,1564013251.924 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-07-25T00:07:32.371Z,1564013252.371 [Default:CheckIn] Running Loop=1 2019-07-25T00:07:32.371Z,1564013252.371 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-07-25T00:07:32.371Z,1564013252.371 [Default:CheckIn:Read_GPS] Running Loop=1 2019-07-25T00:07:32.736Z,1564013252.736 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-07-25T00:07:39.692Z,1564013259.692 [CommandLine](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 36.799999 degree 2019-07-25T00:07:39.694Z,1564013259.694 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread. 2019-07-25T00:07:39.695Z,1564013259.695 [CommandLine](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -121.900002 degree 2019-07-25T00:07:39.696Z,1564013259.696 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread. 2019-07-25T00:07:39.995Z,1564013259.995 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-07-25T00:07:40.381Z,1564013260.381 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:40.381Z,1564013260.381 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2019-07-25T00:07:40.381Z,1564013260.381 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:40.391Z,1564013260.391 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:40.801Z,1564013260.801 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:40.801Z,1564013260.801 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2019-07-25T00:07:41.619Z,1564013261.619 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:41.619Z,1564013261.619 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2019-07-25T00:07:41.619Z,1564013261.619 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:41.638Z,1564013261.638 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:42.031Z,1564013262.031 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:42.032Z,1564013262.032 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2019-07-25T00:07:42.851Z,1564013262.851 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:42.851Z,1564013262.851 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2019-07-25T00:07:42.851Z,1564013262.851 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:42.865Z,1564013262.865 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:43.263Z,1564013263.263 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:43.263Z,1564013263.263 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2019-07-25T00:07:44.013Z,1564013264.013 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:44.013Z,1564013264.013 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2019-07-25T00:07:44.013Z,1564013264.013 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:44.023Z,1564013264.023 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:44.430Z,1564013264.430 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:44.430Z,1564013264.430 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2019-07-25T00:07:45.254Z,1564013265.254 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:45.254Z,1564013265.254 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2019-07-25T00:07:45.254Z,1564013265.254 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:45.264Z,1564013265.264 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:45.653Z,1564013265.653 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:45.653Z,1564013265.653 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2019-07-25T00:07:46.441Z,1564013266.441 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:46.441Z,1564013266.441 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2019-07-25T00:07:46.441Z,1564013266.441 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:46.491Z,1564013266.491 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:46.858Z,1564013266.858 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:46.858Z,1564013266.858 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2019-07-25T00:07:47.676Z,1564013267.676 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:47.676Z,1564013267.676 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2019-07-25T00:07:47.676Z,1564013267.676 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:47.686Z,1564013267.686 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:48.087Z,1564013268.087 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:48.087Z,1564013268.087 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2019-07-25T00:07:48.887Z,1564013268.887 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:48.887Z,1564013268.887 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2019-07-25T00:07:48.887Z,1564013268.887 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:48.897Z,1564013268.897 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:49.291Z,1564013269.291 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:49.291Z,1564013269.291 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2019-07-25T00:07:50.215Z,1564013270.215 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:50.215Z,1564013270.215 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2019-07-25T00:07:50.215Z,1564013270.215 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:50.238Z,1564013270.238 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:50.558Z,1564013270.558 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:50.558Z,1564013270.558 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2019-07-25T00:07:51.439Z,1564013271.439 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:51.439Z,1564013271.439 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2019-07-25T00:07:51.439Z,1564013271.439 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:51.473Z,1564013271.473 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:51.744Z,1564013271.744 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:51.744Z,1564013271.744 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2019-07-25T00:07:52.531Z,1564013272.531 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:52.531Z,1564013272.531 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2019-07-25T00:07:52.531Z,1564013272.531 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:52.545Z,1564013272.545 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:52.947Z,1564013272.947 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:52.947Z,1564013272.947 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2019-07-25T00:07:53.748Z,1564013273.748 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:53.748Z,1564013273.748 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2019-07-25T00:07:53.749Z,1564013273.749 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:53.771Z,1564013273.771 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:54.139Z,1564013274.139 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:54.139Z,1564013274.139 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2019-07-25T00:07:54.944Z,1564013274.944 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:54.944Z,1564013274.944 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2019-07-25T00:07:54.944Z,1564013274.944 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:54.954Z,1564013274.954 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:55.339Z,1564013275.339 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:55.339Z,1564013275.339 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2019-07-25T00:07:56.151Z,1564013276.151 [DeadReckonUsingMultipleVelocitySources](ERROR): Caught NaN! Will not write estimated position: latitude_ = nan, longitude_ = nan, depth_ = nan, horizontalPathLengthSinceLastFix_ = nan, latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan 2019-07-25T00:07:56.151Z,1564013276.151 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2019-07-25T00:07:56.151Z,1564013276.151 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-25T00:07:56.161Z,1564013276.161 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:56.563Z,1564013276.563 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1564013312.000000 second 2019-07-25T00:07:56.573Z,1564013276.573 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-25T00:07:56.573Z,1564013276.573 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2019-07-25T00:07:56.969Z,1564013276.969 [Default:CheckIn:Read_GPS] Stopped 2019-07-25T00:07:56.970Z,1564013276.970 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-07-25T00:07:57.352Z,1564013277.352 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-07-25T00:08:01.012Z,1564013281.012 [CommandLine](IMPORTANT): got command show stack 2019-07-25T00:08:01.012Z,1564013281.012 [CommandLine](IMPORTANT): Behavior Stack: 2019-07-25T00:08:01.012Z,1564013281.012 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface 2019-07-25T00:08:01.012Z,1564013281.012 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_Iridium 2019-07-25T00:08:03.201Z,1564013283.201 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20190725T000219/Courier0004.lzma 2019-07-25T00:08:04.007Z,1564013284.007 [DataOverHttps](INFO): Moved sent file to Logs/20190725T000219/Courier0004.lzma.bak 2019-07-25T00:08:04.007Z,1564013284.007 [DataOverHttps](INFO): SBD MOMSN=11473370 2019-07-25T00:08:11.476Z,1564013291.476 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-07-25T00:08:15.438Z,1564013295.438 [DataOverHttps](INFO): Sending 485 bytes from file Logs/20190725T000219/Express0005.lzma 2019-07-25T00:08:16.243Z,1564013296.243 [DataOverHttps](INFO): Moved sent file to Logs/20190725T000219/Express0005.lzma.bak 2019-07-25T00:08:16.244Z,1564013296.244 [DataOverHttps](INFO): SBD MOMSN=11473372 2019-07-25T00:08:16.757Z,1564013296.757 [Default:CheckIn:Read_Iridium] Stopped 2019-07-25T00:08:16.758Z,1564013296.758 [Default:CheckIn:C.Wait] Running Loop=1 2019-07-25T00:08:16.758Z,1564013296.758 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-07-25T00:08:40.155Z,1564013320.155 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-07-25T00:08:40.155Z,1564013320.155 [DVL_micro] Data Fault, FailCount= 1 2019-07-25T00:08:40.155Z,1564013320.155 [DVL_micro](ERROR): Data Fault 2019-07-25T00:08:40.213Z,1564013320.213 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-07-25T00:08:40.622Z,1564013320.622 [DVL_micro](INFO): uninitialize:Powering down 2019-07-25T00:08:41.396Z,1564013321.396 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-07-25T00:08:41.396Z,1564013321.396 [DVL_micro] No Fault, FailCount= 1 2019-07-25T00:08:41.776Z,1564013321.776 [DVL_micro](INFO): Initializing 2019-07-25T00:08:42.175Z,1564013322.175 [NAL9602](INFO): Not Powering down - fast GPS 2019-07-25T00:08:53.276Z,1564013333.276 [DataOverHttps](IMPORTANT): SBD MTMSN=20190725T000837 2019-07-25T00:08:56.603Z,1564013336.603 [CommandLine](IMPORTANT): got command show best height_above_sea_floor 2019-07-25T00:08:56.603Z,1564013336.603 [CommandLine](IMPORTANT): height_above_sea_floor best is null 2019-07-25T00:09:00.162Z,1564013340.162 [DataOverHttps](INFO): Received command:sched asap "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 10 minute;set profile_station.Lat 36.797 degree;set profile_station.Lon -121.847 degree" 3pq8 1 2 2019-07-25T00:09:00.192Z,1564013340.192 [CommandLine](IMPORTANT): got command schedule asap "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 10 minute;set profile_station.Lat 36.797 degree;set profile_station.Lon -121.847 degree" 3pq8 1 2.000000 2019-07-25T00:09:00.193Z,1564013340.193 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=3pq8 2019-07-25T00:09:00.194Z,1564013340.194 [CommandLine](IMPORTANT): Scheduled #1 (#1 of 2 with id='3pq8'): "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 10 minute;set profile_station.Lat 36.797 degree;set profile_station.Lon -121.847 degree" ASAP 2019-07-25T00:09:00.967Z,1564013340.967 [DataOverHttps](IMPORTANT): SBD MTMSN=20190725T000845 2019-07-25T00:09:01.796Z,1564013341.796 [CommandLine](IMPORTANT): got command 2019-07-25T00:09:01.796Z,1564013341.796 [CommandLine](FAULT): Incomplete syntax. Try: help 2019-07-25T00:09:07.390Z,1564013347.390 [DataOverHttps](INFO): Received command:sched asap "set profile_station.YoYoMaxDepth 30 meter;set profile_station.MaxDepth 35 meter;set profile_station.MinOffshore 0.5 kilometer;run " 3pq8 2 2 2019-07-25T00:09:07.421Z,1564013347.421 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.YoYoMaxDepth 30 meter;set profile_station.MaxDepth 35 meter;set profile_station.MinOffshore 0.5 kilometer;run " 3pq8 2 2.000000 2019-07-25T00:09:07.421Z,1564013347.421 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=3pq8 2019-07-25T00:09:07.422Z,1564013347.422 [CommandLine](IMPORTANT): Scheduled #2 (#2 of 2 with id='3pq8'): "set profile_station.YoYoMaxDepth 30 meter;set profile_station.MaxDepth 35 meter;set profile_station.MinOffshore 0.5 kilometer;run " ASAP 2019-07-25T00:09:07.542Z,1564013347.542 [CommandLine](IMPORTANT): got command load ./Missions/Science/profile_station.xml 2019-07-25T00:09:07.542Z,1564013347.542 [MissionManager](INFO): Loading Mission: ./Missions/Science/profile_station.xml 2019-07-25T00:09:07.688Z,1564013347.688 [MissionManager](INFO): DefineArg profile_station.MissionTimeout = 4.000000 h 2019-07-25T00:09:07.695Z,1564013347.695 [MissionManager](INFO): DefineArg profile_station.NeedCommsTime = 60.000000 min 2019-07-25T00:09:07.707Z,1564013347.707 [MissionManager](INFO): DefineArg profile_station.Lat = 36.806966 arcdeg 2019-07-25T00:09:07.728Z,1564013347.728 [MissionManager](INFO): DefineArg profile_station.Lon = -121.824326 arcdeg 2019-07-25T00:09:07.735Z,1564013347.735 [MissionManager](INFO): DefineArg profile_station.Radius = 300.000000 m 2019-07-25T00:09:07.743Z,1564013347.743 [MissionManager](INFO): DefineArg profile_station.YoYoMinDepth = 2.000000 m 2019-07-25T00:09:07.752Z,1564013347.752 [MissionManager](INFO): DefineArg profile_station.YoYoMaxDepth = 200.000000 m 2019-07-25T00:09:07.782Z,1564013347.782 [MissionManager](INFO): DefineArg profile_station.YoYoMinAltitude = 7.000000 m 2019-07-25T00:09:07.788Z,1564013347.788 [MissionManager](INFO): DefineArg profile_station.YoYoPitch = 20.000000 arcdeg 2019-07-25T00:09:07.792Z,1564013347.792 [MissionManager](INFO): DefineArg profile_station.Speed = 1.000000 m/s 2019-07-25T00:09:07.796Z,1564013347.796 [MissionManager](INFO): DefineArg profile_station.CircleMaxError = 100.000000 m 2019-07-25T00:09:07.810Z,1564013347.810 [MissionManager](INFO): DefineArg profile_station.CircleTurnToPort = 0 bool 2019-07-25T00:09:07.813Z,1564013347.813 [MissionManager](INFO): DefineArg profile_station.KwpHeading = 0.010000 rad/m 2019-07-25T00:09:07.821Z,1564013347.821 [MissionManager](INFO): DefineArg profile_station.MinAltitude = 5.000000 m 2019-07-25T00:09:07.829Z,1564013347.829 [MissionManager](INFO): DefineArg profile_station.MaxDepth = 205.000000 m 2019-07-25T00:09:07.832Z,1564013347.832 [MissionManager](INFO): DefineArg profile_station.MinOffshore = 2.000000 km 2019-07-25T00:09:07.833Z,1564013347.833 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml 2019-07-25T00:09:08.254Z,1564013348.254 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUS = 0 bool 2019-07-25T00:09:08.258Z,1564013348.258 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUSmaxPitch = 60.000000 arcdeg 2019-07-25T00:09:08.269Z,1564013348.269 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUSminPitch = -60.000000 arcdeg 2019-07-25T00:09:08.284Z,1564013348.284 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectChlActive = 0 bool 2019-07-25T00:09:08.287Z,1564013348.287 [MissionManager](INFO): DefineArg profile_station:Science.TimeWindowPeakReport = nan min 2019-07-25T00:09:08.290Z,1564013348.290 [MissionManager](INFO): DefineArg profile_station:Science.HighestChlPeakReportActive = 0 bool 2019-07-25T00:09:08.293Z,1564013348.293 [MissionManager](INFO): DefineArg profile_station:Science.PatchTracking = 0 bool 2019-07-25T00:09:08.302Z,1564013348.302 [MissionManager](INFO): DefineArg profile_station:Science.FilterWidthHorizontal = 3.000000 count 2019-07-25T00:09:08.306Z,1564013348.306 [MissionManager](INFO): DefineArg profile_station:Science.NumProfilesSlidingwindow = 100.000000 count 2019-07-25T00:09:08.309Z,1564013348.309 [MissionManager](INFO): DefineArg profile_station:Science.OffPeakFractionHorizontal = 80.000000 % 2019-07-25T00:09:08.320Z,1564013348.320 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectNO3Active = 0 bool 2019-07-25T00:09:08.323Z,1564013348.323 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectOilActive = 0 bool 2019-07-25T00:09:08.334Z,1564013348.334 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectFDOMActive = 0 bool 2019-07-25T00:09:08.337Z,1564013348.337 [MissionManager](INFO): DefineArg profile_station:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2019-07-25T00:09:08.355Z,1564013348.355 [MissionManager](INFO): DefineArg profile_station:Science.EnabledAanderaaO2 = 1.000000 bool 2019-07-25T00:09:08.360Z,1564013348.360 [MissionManager](INFO): DefineArg profile_station:Science.EnabledNeilBrown = 0.000000 bool 2019-07-25T00:09:08.376Z,1564013348.376 [MissionManager](INFO): DefineArg profile_station:Science.EnabledSeabird = 1.000000 bool 2019-07-25T00:09:08.394Z,1564013348.394 [MissionManager](INFO): DefineArg profile_station:Science.EnabledTurbulence_NPS = 0.000000 bool 2019-07-25T00:09:08.402Z,1564013348.402 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsBB2FL = 1.000000 bool 2019-07-25T00:09:08.405Z,1564013348.405 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool 2019-07-25T00:09:08.413Z,1564013348.413 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsUBAT = 0.000000 bool 2019-07-25T00:09:08.468Z,1564013348.468 [MissionManager](INFO): DefineArg profile_station:Science.EnabledISUS = 0.000000 bool 2019-07-25T00:09:08.486Z,1564013348.486 [MissionManager](INFO): DefineArg profile_station:Science.LowPassWindowLength = 20.000000 count 2019-07-25T00:09:08.497Z,1564013348.497 [MissionManager](INFO): DefineArg profile_station:Science.MedianFilterLen = 5.000000 count 2019-07-25T00:09:08.508Z,1564013348.508 [MissionManager](INFO): DefineArg profile_station:Science.PeakChlShallowBound = nan m 2019-07-25T00:09:08.515Z,1564013348.515 [MissionManager](INFO): DefineArg profile_station:Science.PeakChlDeepBound = nan m 2019-07-25T00:09:08.522Z,1564013348.522 [MissionManager](INFO): DefineArg profile_station:Science.PeakShallowBound = nan m 2019-07-25T00:09:08.525Z,1564013348.525 [MissionManager](INFO): DefineArg profile_station:Science.PeakDeepBound = nan m 2019-07-25T00:09:08.536Z,1564013348.536 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChl = 0.000000 ug/l 2019-07-25T00:09:08.540Z,1564013348.540 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlDepth = 0.000000 m 2019-07-25T00:09:08.555Z,1564013348.555 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlTemperature = 0.000000 degC 2019-07-25T00:09:08.564Z,1564013348.564 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLatitude = nan arcdeg 2019-07-25T00:09:08.572Z,1564013348.572 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLongitude = nan arcdeg 2019-07-25T00:09:08.584Z,1564013348.584 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3 = 0.000000 umol/l 2019-07-25T00:09:08.591Z,1564013348.591 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Depth = 0.000000 m 2019-07-25T00:09:08.599Z,1564013348.599 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Latitude = nan arcdeg 2019-07-25T00:09:08.612Z,1564013348.612 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Longitude = nan arcdeg 2019-07-25T00:09:08.619Z,1564013348.619 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChl = 0.000000 m 2019-07-25T00:09:08.626Z,1564013348.626 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDepth = 0.000000 m 2019-07-25T00:09:08.629Z,1564013348.629 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLatitude = nan arcdeg 2019-07-25T00:09:08.636Z,1564013348.636 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLongitude = nan arcdeg 2019-07-25T00:09:08.655Z,1564013348.655 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDistance = nan m 2019-07-25T00:09:08.663Z,1564013348.663 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOil = 0.000000 kg/m3 2019-07-25T00:09:08.670Z,1564013348.670 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilDepth = 0.000000 m 2019-07-25T00:09:08.673Z,1564013348.673 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLatitude = nan arcdeg 2019-07-25T00:09:08.680Z,1564013348.680 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLongitude = nan arcdeg 2019-07-25T00:09:08.692Z,1564013348.692 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOM = 0.000000 ppb 2019-07-25T00:09:08.699Z,1564013348.699 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMDepth = 0.000000 m 2019-07-25T00:09:08.703Z,1564013348.703 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLatitude = nan arcdeg 2019-07-25T00:09:08.712Z,1564013348.712 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLongitude = nan arcdeg 2019-07-25T00:09:08.717Z,1564013348.717 [MissionManager](INFO): DefineOutput profile_station:Science.PatchFDOMDistance = nan m 2019-07-25T00:09:08.776Z,1564013348.776 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2019-07-25T00:09:08.805Z,1564013348.805 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2019-07-25T00:09:08.898Z,1564013348.898 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2019-07-25T00:09:08.921Z,1564013348.921 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2019-07-25T00:09:08.948Z,1564013348.948 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2019-07-25T00:09:08.979Z,1564013348.979 [MissionManager](INFO): RedefineArg profile_station:Science.SampleISUS = value:1 bool 2019-07-25T00:09:08.981Z,1564013348.981 [MissionManager](INFO): RedefineArg profile_station:Science.PeakDetectChlActive = value:1 bool 2019-07-25T00:09:08.981Z,1564013348.981 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2019-07-25T00:09:09.077Z,1564013349.077 [MissionManager](INFO): DefineArg profile_station:NeedComms.DiveInterval = 3.000000 h 2019-07-25T00:09:09.080Z,1564013349.080 [MissionManager](INFO): DefineArg profile_station:NeedComms.WaitForPitchUp = 10.000000 min 2019-07-25T00:09:09.097Z,1564013349.097 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfacePitch = 20.000000 arcdeg 2019-07-25T00:09:09.101Z,1564013349.101 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceDepthRate = nan m/s 2019-07-25T00:09:09.104Z,1564013349.104 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceSpeed = 1.000000 m/s 2019-07-25T00:09:09.119Z,1564013349.119 [MissionManager](INFO): DefineArg profile_station:NeedComms.GPSTimeout = 7.000000 min 2019-07-25T00:09:09.123Z,1564013349.123 [MissionManager](INFO): DefineArg profile_station:NeedComms.CommsTimeout = 30.000000 min 2019-07-25T00:09:09.128Z,1564013349.128 [profile_station:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-07-25T00:09:09.183Z,1564013349.183 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2019-07-25T00:09:09.288Z,1564013349.288 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinAltitude = 5.000000 m 2019-07-25T00:09:09.291Z,1564013349.291 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MaxDepth = 200.000000 m 2019-07-25T00:09:09.309Z,1564013349.309 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinOffshore = 2000.000000 m 2019-07-25T00:09:09.310Z,1564013349.310 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2019-07-25T00:09:09.318Z,1564013349.318 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2019-07-25T00:09:09.357Z,1564013349.357 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2019-07-25T00:09:09.388Z,1564013349.388 [profile_station:I.Pitch](DEBUG): Construct. 2019-07-25T00:09:09.393Z,1564013349.393 [profile_station:J.Buoyancy](DEBUG): Construct Buoyancy. 2019-07-25T00:09:09.397Z,1564013349.397 [profile_station:K.SetSpeed](DEBUG): Construct. 2019-07-25T00:09:09.421Z,1564013349.421 [profile_station:L.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2019-07-25T00:09:09.439Z,1564013349.439 [profile_station:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2019-07-25T00:09:09.469Z,1564013349.469 [profile_station:N.YoYo](DEBUG): Construct YoYo. 2019-07-25T00:09:09.483Z,1564013349.483 [profile_station:CircleWrapper:B.Circle](DEBUG): Construct. 2019-07-25T00:09:09.559Z,1564013349.559 [MissionManager](DEBUG): This mission yoyos in a circle around a specified location. Maximum duration of mission 4 Elapsed time after previous surface communications when vehicle will begin to ascend for additional surface communications 60 The latitude of the center of the circle. 36.806966 The longitude of the center of the circle. -121.824326 Radius to circle at 300 Minimum depth while performing the YoYo behavior. 2 Maximum depth while performing the YoYo behavior. 200 Minimum altitude while performing the YoYo behavior (for bottom-terminated YoYos). 7 Pitch (plus and minus) for yo-yo behavior. 20 Vehicle speed. 1 If this distance away from the circle, drive straight towards (or away from the center). Otherwise, try to reduce distance from the ideal circle. 100 If true, vehicle turns to the left around the center point. If false, vehicle turns to the right. Used to relax waypoint cross-track error constant that is adjusted for docking. (You can override this setting by passing an argument.) 0.010 Minimum height above the sea floor for the entire mission. 5 Maximum depth for the entire mission. 205 Minimum offshore distance for the entire mission. 2 Most missions will run the science sensors. If you don't place this aggregate above NeedComms, science instruments get turned off on the last upcast and while floating on the surface. Another depth envelope for the YoYo behavior. This envelope should fall within the limits of the standard safety envelopes in Insert/StandardEnvelopes.xml in order to avoid commanding high pitch angles for depth-terminated YoYos. Another altitude envelope for the YoYo behavior. This envelope should fall within the limits of the standard safety envelopes in Insert/StandardEnvelopes.xml in order to avoid commanding high pitch angles for bottom-terminated YoYos. 2019-07-25T00:09:09.560Z,1564013349.560 [CommandLine](IMPORTANT): Loaded ./Missions/Science/profile_station.xml 2019-07-25T00:09:19.053Z,1564013359.053 [CommandLine](IMPORTANT): got command set profile_station.MissionTimeout 2.000000 hour 2019-07-25T00:09:19.065Z,1564013359.065 [CommandLine](IMPORTANT): got command set profile_station.NeedCommsTime 10.000000 minute 2019-07-25T00:09:19.066Z,1564013359.066 [CommandLine](IMPORTANT): got command set profile_station.Lat 36.797001 degree 2019-07-25T00:09:19.067Z,1564013359.067 [CommandLine](IMPORTANT): got command set profile_station.Lon -121.847000 degree 2019-07-25T00:09:26.099Z,1564013366.099 [CommandLine](IMPORTANT): got command set profile_station.YoYoMaxDepth 30.000000 meter 2019-07-25T00:09:26.100Z,1564013366.100 [CommandLine](IMPORTANT): got command set profile_station.MaxDepth 35.000000 meter 2019-07-25T00:09:26.100Z,1564013366.100 [CommandLine](IMPORTANT): got command set profile_station.MinOffshore 0.500000 kilometer 2019-07-25T00:09:26.101Z,1564013366.101 [CommandLine](IMPORTANT): got command run 2019-07-25T00:09:26.104Z,1564013366.104 [CommandLine](IMPORTANT): Running 2019-07-25T00:09:26.277Z,1564013366.277 [Default] Stopped 2019-07-25T00:09:26.277Z,1564013366.277 [Default](DEBUG): Aggregate::uninitialize Default 2019-07-25T00:09:26.277Z,1564013366.277 [Default:B.GoToSurface] Stopped 2019-07-25T00:09:26.278Z,1564013366.278 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-25T00:09:26.278Z,1564013366.278 [Default:CheckIn] Stopped 2019-07-25T00:09:26.278Z,1564013366.278 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-07-25T00:09:26.278Z,1564013366.278 [Default:CheckIn:C.Wait] Stopped 2019-07-25T00:09:26.278Z,1564013366.278 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-07-25T00:09:26.278Z,1564013366.278 [MissionManager](IMPORTANT): Started mission profile_station 2019-07-25T00:09:26.278Z,1564013366.278 [profile_station] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station](DEBUG): Aggregate::initialize profile_station 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science](DEBUG): Aggregate::initialize profile_station:Science 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:A] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:B] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:C] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:D] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:E] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:F] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:G] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:H] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:Read_Oil] Running Loop=1 2019-07-25T00:09:26.279Z,1564013366.279 [profile_station:Science:PeakDetectChl] Running Loop=1 2019-07-25T00:09:26.280Z,1564013366.280 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectChl 2019-07-25T00:09:26.280Z,1564013366.280 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2019-07-25T00:09:26.280Z,1564013366.280 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2019-07-25T00:09:26.282Z,1564013366.282 [profile_station:Science:HighestChlPeakReport] Running Loop=1 2019-07-25T00:09:26.282Z,1564013366.282 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize profile_station:Science:HighestChlPeakReport 2019-07-25T00:09:26.282Z,1564013366.282 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2019-07-25T00:09:26.282Z,1564013366.282 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2019-07-25T00:09:26.283Z,1564013366.283 [profile_station:Science:PeakDetectNO3] Running Loop=1 2019-07-25T00:09:26.283Z,1564013366.283 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectNO3 2019-07-25T00:09:26.283Z,1564013366.283 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2019-07-25T00:09:26.283Z,1564013366.283 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2019-07-25T00:09:26.285Z,1564013366.285 [profile_station:Science:PeakDetectOil] Running Loop=1 2019-07-25T00:09:26.285Z,1564013366.285 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectOil 2019-07-25T00:09:26.285Z,1564013366.285 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2019-07-25T00:09:26.285Z,1564013366.285 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2019-07-25T00:09:26.298Z,1564013366.298 [profile_station:Science:PeakDetectFDOM] Running Loop=1 2019-07-25T00:09:26.298Z,1564013366.298 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectFDOM 2019-07-25T00:09:26.299Z,1564013366.299 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2019-07-25T00:09:26.299Z,1564013366.299 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2019-07-25T00:09:26.301Z,1564013366.301 [profile_station:StandardEnvelopes] Running Loop=1 2019-07-25T00:09:26.301Z,1564013366.301 [profile_station:StandardEnvelopes](DEBUG): Aggregate::initialize profile_station:StandardEnvelopes 2019-07-25T00:09:26.301Z,1564013366.301 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2019-07-25T00:09:26.301Z,1564013366.301 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2019-07-25T00:09:26.302Z,1564013366.302 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2019-07-25T00:09:26.302Z,1564013366.302 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2019-07-25T00:09:26.302Z,1564013366.302 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2019-07-25T00:09:26.302Z,1564013366.302 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2019-07-25T00:09:26.302Z,1564013366.302 [profile_station:I.Pitch] Running Loop=1 2019-07-25T00:09:26.302Z,1564013366.302 [profile_station:I.Pitch](DEBUG): Initialize. 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:J.Buoyancy] Running Loop=1 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:J.Buoyancy](DEBUG): Initialize Buoyancy Component. 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:K.SetSpeed] Running Loop=1 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:K.SetSpeed](DEBUG): Initialize. 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:L.DepthEnvelope] Running Loop=1 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:M.AltitudeEnvelope] Running Loop=1 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2019-07-25T00:09:26.303Z,1564013366.303 [profile_station:N.YoYo] Running Loop=1 2019-07-25T00:09:26.304Z,1564013366.304 [profile_station:N.YoYo](DEBUG): Initialize YoYoComponent. 2019-07-25T00:09:26.304Z,1564013366.304 [profile_station:C] Running Loop=1 2019-07-25T00:09:26.304Z,1564013366.304 [profile_station:N.YoYo] Running Loop=1 2019-07-25T00:09:26.305Z,1564013366.305 [profile_station:M.AltitudeEnvelope] Running Loop=1 2019-07-25T00:09:26.305Z,1564013366.305 [profile_station:L.DepthEnvelope] Running Loop=1 2019-07-25T00:09:26.322Z,1564013366.322 [profile_station:K.SetSpeed] Running Loop=1 2019-07-25T00:09:26.322Z,1564013366.322 [profile_station:J.Buoyancy] Running Loop=1 2019-07-25T00:09:26.322Z,1564013366.322 [profile_station:I.Pitch] Running Loop=1 2019-07-25T00:09:26.323Z,1564013366.323 [profile_station:StandardEnvelopes] Running Loop=1 2019-07-25T00:09:26.323Z,1564013366.323 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2019-07-25T00:09:26.323Z,1564013366.323 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2019-07-25T00:09:26.323Z,1564013366.323 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2019-07-25T00:09:26.324Z,1564013366.324 [profile_station:C] Stopped 2019-07-25T00:09:26.324Z,1564013366.324 [profile_station:E] Running Loop=1 2019-07-25T00:09:26.324Z,1564013366.324 [profile_station:Science] Running Loop=1 2019-07-25T00:09:26.325Z,1564013366.325 [profile_station:Science:PeakDetectFDOM] Stopped 2019-07-25T00:09:26.325Z,1564013366.325 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectFDOM 2019-07-25T00:09:26.325Z,1564013366.325 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectOil] Stopped 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectOil 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectNO3] Stopped 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectNO3 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:HighestChlPeakReport] Stopped 2019-07-25T00:09:26.326Z,1564013366.326 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize profile_station:Science:HighestChlPeakReport 2019-07-25T00:09:26.327Z,1564013366.327 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2019-07-25T00:09:26.327Z,1564013366.327 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2019-07-25T00:09:26.327Z,1564013366.327 [profile_station:Science:PeakDetectChl] Running Loop=1 2019-07-25T00:09:26.327Z,1564013366.327 [profile_station:Science:Read_Oil] Stopped 2019-07-25T00:09:26.327Z,1564013366.327 [profile_station:Science:H] Stopped 2019-07-25T00:09:26.327Z,1564013366.327 [profile_station:Science:G] Running Loop=1 2019-07-25T00:09:26.328Z,1564013366.328 [profile_station:Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2019-07-25T00:09:26.328Z,1564013366.328 [profile_station:Science:F] Stopped 2019-07-25T00:09:26.328Z,1564013366.328 [profile_station:Science:E] Stopped 2019-07-25T00:09:26.328Z,1564013366.328 [profile_station:Science:D] Running Loop=1 2019-07-25T00:09:26.329Z,1564013366.329 [profile_station:Science:D](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2019-07-25T00:09:26.329Z,1564013366.329 [profile_station:Science:D](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2019-07-25T00:09:26.329Z,1564013366.329 [profile_station:Science:C] Running Loop=1 2019-07-25T00:09:26.342Z,1564013366.342 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2019-07-25T00:09:26.343Z,1564013366.343 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2019-07-25T00:09:26.343Z,1564013366.343 [profile_station:Science:B] Stopped 2019-07-25T00:09:26.343Z,1564013366.343 [profile_station:Science:A] Running Loop=1 2019-07-25T00:09:26.344Z,1564013366.344 [profile_station:Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water 2019-07-25T00:09:26.494Z,1564013366.494 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2 2019-07-25T00:09:26.494Z,1564013366.494 [WetLabsBB2FL](INFO): Powering up 2019-07-25T00:09:26.664Z,1564013366.664 [profile_station:E] Stopped 2019-07-25T00:09:26.664Z,1564013366.664 [profile_station:F] Running Loop=1 2019-07-25T00:09:27.074Z,1564013367.074 [profile_station:F] Stopped 2019-07-25T00:09:27.074Z,1564013367.074 [profile_station:G] Running Loop=1 2019-07-25T00:09:27.106Z,1564013367.106 [BuoyancyServo](FAULT): Reading outside of valid range:0.000000 2019-07-25T00:09:27.106Z,1564013367.106 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2019-07-25T00:09:27.107Z,1564013367.107 [BuoyancyServo] Hardware Fault, FailCount= 1 2019-07-25T00:09:27.107Z,1564013367.107 [BuoyancyServo](ERROR): Hardware Fault 2019-07-25T00:09:27.227Z,1564013367.227 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-07-25T00:09:27.265Z,1564013367.265 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2019-07-25T00:09:27.470Z,1564013367.470 [profile_station:G] Stopped 2019-07-25T00:09:27.470Z,1564013367.470 [profile_station:StartingMission] Running Loop=1 2019-07-25T00:09:27.470Z,1564013367.470 [profile_station:StartingMission](DEBUG): Aggregate::initialize profile_station:StartingMission 2019-07-25T00:09:27.867Z,1564013367.867 [profile_station:M.AltitudeEnvelope](ERROR): Altitude Measurement is not Active. 2019-07-25T00:09:27.869Z,1564013367.869 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active. 2019-07-25T00:09:27.869Z,1564013367.869 [profile_station:NeedComms] Running Loop=1 2019-07-25T00:09:27.869Z,1564013367.869 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms 2019-07-25T00:09:27.869Z,1564013367.869 [profile_station:NeedComms:B.GoToSurface] Running Loop=1 2019-07-25T00:09:27.869Z,1564013367.869 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-25T00:09:27.870Z,1564013367.870 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2019-07-25T00:09:27.870Z,1564013367.870 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2019-07-25T00:09:27.871Z,1564013367.871 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2019-07-25T00:09:27.871Z,1564013367.871 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-25T00:09:27.871Z,1564013367.871 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-25T00:09:27.872Z,1564013367.872 [profile_station:NeedComms:A] Running Loop=1 2019-07-25T00:09:27.873Z,1564013367.873 [profile_station:NeedComms:A](INFO): last time_fix was: 1564013312.000000 second since 1970/01/01T00:00:00Z 2019-07-25T00:09:27.873Z,1564013367.873 [profile_station:NeedComms:A] Stopped 2019-07-25T00:09:28.291Z,1564013368.291 [profile_station:NeedComms:C] Running Loop=1 2019-07-25T00:09:28.663Z,1564013368.663 [profile_station:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-07-25T00:09:29.076Z,1564013369.076 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-07-25T00:09:29.076Z,1564013369.076 [BuoyancyServo](INFO): Powering down 2019-07-25T00:09:29.858Z,1564013369.858 [NAL9602](DEBUG): Fix Requested 2019-07-25T00:09:29.898Z,1564013369.898 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2019-07-25T00:09:29.898Z,1564013369.898 [BuoyancyServo] No Fault, FailCount= 1 2019-07-25T00:09:30.239Z,1564013370.239 [CTD_Seabird](ERROR): Failed to parse device response: 2019-07-25T00:09:30.325Z,1564013370.325 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-07-25T00:09:30.326Z,1564013370.326 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-07-25T00:09:32.249Z,1564013372.249 [CTD_Seabird](ERROR): Salinity reading out of range: 0.350017 psu 2019-07-25T00:09:33.253Z,1564013373.253 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349956 psu 2019-07-25T00:09:33.508Z,1564013373.508 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:09:33.508Z,1564013373.508 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 92 288 16 -16 2 3 2 2 101.4 405.7 102.4 2 -40.3 -416.2 102.4 2 101 405 102 2 -40 -416 102 2 1.03 -1.52 188.5 -3..005 35.0 1489 123 2019-07-25T00:09:34.257Z,1564013374.257 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349891 psu 2019-07-25T00:09:35.261Z,1564013375.261 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349826 psu 2019-07-25T00:09:36.265Z,1564013376.265 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349823 psu 2019-07-25T00:09:37.269Z,1564013377.269 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349817 psu 2019-07-25T00:09:38.273Z,1564013378.273 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349756 psu 2019-07-25T00:09:38.756Z,1564013378.756 [CommandLine](IMPORTANT): got command show variable speedContorl 2019-07-25T00:09:39.277Z,1564013379.277 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349754 psu 2019-07-25T00:09:40.281Z,1564013380.281 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349745 psu 2019-07-25T00:09:41.284Z,1564013381.284 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349681 psu 2019-07-25T00:09:42.288Z,1564013382.288 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349673 psu 2019-07-25T00:09:42.772Z,1564013382.772 [CommandLine](IMPORTANT): got command show variable speedControl 2019-07-25T00:09:42.927Z,1564013382.927 [CommandLine](IMPORTANT): SpeedControl.loadAtStartup (bool) 2019-07-25T00:09:42.928Z,1564013382.928 [CommandLine](IMPORTANT): SpeedControl.propPitch (meter_per_radian) 2019-07-25T00:09:42.982Z,1564013382.982 [CommandLine](IMPORTANT): SpeedControl.propOmegaAction (radian_per_second) 2019-07-25T00:09:42.983Z,1564013382.983 [CommandLine](IMPORTANT): SpeedControl.speedCmd (meter_per_second) 2019-07-25T00:09:43.292Z,1564013383.292 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349671 psu 2019-07-25T00:09:44.296Z,1564013384.296 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349606 psu 2019-07-25T00:09:45.300Z,1564013385.300 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349597 psu 2019-07-25T00:09:46.304Z,1564013386.304 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349534 psu 2019-07-25T00:09:47.308Z,1564013387.308 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349522 psu 2019-07-25T00:09:48.312Z,1564013388.312 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349516 psu 2019-07-25T00:09:49.316Z,1564013389.316 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349405 psu 2019-07-25T00:09:50.320Z,1564013390.320 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349404 psu 2019-07-25T00:09:51.324Z,1564013391.324 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349357 psu 2019-07-25T00:09:52.328Z,1564013392.328 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349358 psu 2019-07-25T00:09:52.748Z,1564013392.748 [CommandLine](IMPORTANT): got command report mod SpeedControl.speedCmd 2019-07-25T00:09:52.999Z,1564013392.999 [Reporter](INFO): SpeedControl.speedCmd 0.000000 m/s 2019-07-25T00:09:53.332Z,1564013393.332 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349302 psu 2019-07-25T00:09:54.336Z,1564013394.336 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349302 psu 2019-07-25T00:09:55.340Z,1564013395.340 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349239 psu 2019-07-25T00:09:56.344Z,1564013396.344 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349181 psu 2019-07-25T00:09:57.348Z,1564013397.348 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349170 psu 2019-07-25T00:09:58.352Z,1564013398.352 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349109 psu 2019-07-25T00:09:59.356Z,1564013399.356 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349098 psu 2019-07-25T00:10:00.360Z,1564013400.360 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349094 psu 2019-07-25T00:10:00.965Z,1564013400.965 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2019-07-25T00:10:01.038Z,1564013401.038 [NAL9602](FAULT): received: +CSQ:0 OK 2019-07-25T00:10:01.038Z,1564013401.038 [NAL9602] Data Fault, FailCount= 1 2019-07-25T00:10:01.038Z,1564013401.038 [NAL9602](ERROR): Data Fault 2019-07-25T00:10:01.141Z,1564013401.141 [CBIT](ERROR): Data Fault in component: NAL9602 2019-07-25T00:10:01.364Z,1564013401.364 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349031 psu 2019-07-25T00:10:01.368Z,1564013401.368 [NAL9602](INFO): Powering down 2019-07-25T00:10:02.225Z,1564013402.225 [CBIT](INFO): Clearing failed state for component NAL9602 2019-07-25T00:10:02.225Z,1564013402.225 [NAL9602] No Fault, FailCount= 1 2019-07-25T00:10:02.368Z,1564013402.368 [CTD_Seabird](ERROR): Salinity reading out of range: 0.349021 psu 2019-07-25T00:10:03.372Z,1564013403.372 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348957 psu 2019-07-25T00:10:04.376Z,1564013404.376 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348954 psu 2019-07-25T00:10:05.039Z,1564013405.039 [BPC1](ERROR): Battery stick #38 (s/n: 0139) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2019-07-25T00:10:05.039Z,1564013405.039 [BPC1](ERROR): Battery stick #39 (s/n: 00F0) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0. 2019-07-25T00:10:05.040Z,1564013405.040 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5. 2019-07-25T00:10:05.047Z,1564013405.047 [BPC1](INFO): Received data from all battery sticks. 2019-07-25T00:10:05.380Z,1564013405.380 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348889 psu 2019-07-25T00:10:06.384Z,1564013406.384 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348896 psu 2019-07-25T00:10:06.455Z,1564013406.455 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1564013440.000000 second 2019-07-25T00:10:07.388Z,1564013407.388 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348841 psu 2019-07-25T00:10:08.392Z,1564013408.392 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348788 psu 2019-07-25T00:10:09.396Z,1564013409.396 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348724 psu 2019-07-25T00:10:10.400Z,1564013410.400 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348726 psu 2019-07-25T00:10:11.405Z,1564013411.405 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348668 psu 2019-07-25T00:10:12.409Z,1564013412.409 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348662 psu 2019-07-25T00:10:13.413Z,1564013413.413 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348597 psu 2019-07-25T00:10:14.417Z,1564013414.417 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348543 psu 2019-07-25T00:10:15.421Z,1564013415.421 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348487 psu 2019-07-25T00:10:16.428Z,1564013416.428 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348479 psu 2019-07-25T00:10:17.432Z,1564013417.432 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348423 psu 2019-07-25T00:10:18.436Z,1564013418.436 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348367 psu 2019-07-25T00:10:19.440Z,1564013419.440 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348364 psu 2019-07-25T00:10:20.444Z,1564013420.444 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348309 psu 2019-07-25T00:10:21.448Z,1564013421.448 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348317 psu 2019-07-25T00:10:22.452Z,1564013422.452 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348254 psu 2019-07-25T00:10:23.456Z,1564013423.456 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348203 psu 2019-07-25T00:10:24.460Z,1564013424.460 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348198 psu 2019-07-25T00:10:25.464Z,1564013425.464 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348137 psu 2019-07-25T00:10:26.468Z,1564013426.468 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348075 psu 2019-07-25T00:10:27.472Z,1564013427.472 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348073 psu 2019-07-25T00:10:28.476Z,1564013428.476 [CTD_Seabird](ERROR): Salinity reading out of range: 0.348003 psu 2019-07-25T00:10:29.480Z,1564013429.480 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347949 psu 2019-07-25T00:10:30.485Z,1564013430.485 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347944 psu 2019-07-25T00:10:31.488Z,1564013431.488 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347884 psu 2019-07-25T00:10:31.708Z,1564013431.708 [NAL9602](INFO): Powering up NAL9602 2019-07-25T00:10:32.492Z,1564013432.492 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347878 psu 2019-07-25T00:10:33.496Z,1564013433.496 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347816 psu 2019-07-25T00:10:34.500Z,1564013434.500 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347751 psu 2019-07-25T00:10:35.504Z,1564013435.504 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347695 psu 2019-07-25T00:10:36.508Z,1564013436.508 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347685 psu 2019-07-25T00:10:37.512Z,1564013437.512 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347626 psu 2019-07-25T00:10:38.516Z,1564013438.516 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347622 psu 2019-07-25T00:10:39.520Z,1564013439.520 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347558 psu 2019-07-25T00:10:40.525Z,1564013440.525 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347495 psu 2019-07-25T00:10:41.529Z,1564013441.529 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347487 psu 2019-07-25T00:10:42.533Z,1564013442.533 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347483 psu 2019-07-25T00:10:42.607Z,1564013442.607 [NAL9602](INFO): NAL9602 initialized 2019-07-25T00:10:43.418Z,1564013443.418 [NAL9602](DEBUG): Fix Requested 2019-07-25T00:10:43.537Z,1564013443.537 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347420 psu 2019-07-25T00:10:44.541Z,1564013444.541 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347365 psu 2019-07-25T00:10:45.544Z,1564013445.544 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347303 psu 2019-07-25T00:10:46.548Z,1564013446.548 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347297 psu 2019-07-25T00:10:47.578Z,1564013447.578 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347238 psu 2019-07-25T00:10:48.556Z,1564013448.556 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347178 psu 2019-07-25T00:10:49.560Z,1564013449.560 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347171 psu 2019-07-25T00:10:50.564Z,1564013450.564 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347113 psu 2019-07-25T00:10:51.568Z,1564013451.568 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347109 psu 2019-07-25T00:10:52.572Z,1564013452.572 [CTD_Seabird](ERROR): Salinity reading out of range: 0.347045 psu 2019-07-25T00:10:52.709Z,1564013452.709 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool 2019-07-25T00:10:53.576Z,1564013453.576 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346930 psu 2019-07-25T00:10:54.580Z,1564013454.580 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346876 psu 2019-07-25T00:10:55.584Z,1564013455.584 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346874 psu 2019-07-25T00:10:56.588Z,1564013456.588 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346814 psu 2019-07-25T00:10:57.628Z,1564013457.628 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346765 psu 2019-07-25T00:10:58.631Z,1564013458.631 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346775 psu 2019-07-25T00:10:59.635Z,1564013459.635 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346726 psu 2019-07-25T00:11:00.639Z,1564013460.639 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346784 psu 2019-07-25T00:11:01.643Z,1564013461.643 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346676 psu 2019-07-25T00:11:02.635Z,1564013462.635 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346674 psu 2019-07-25T00:11:03.639Z,1564013463.639 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346626 psu 2019-07-25T00:11:04.643Z,1564013464.643 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346568 psu 2019-07-25T00:11:05.647Z,1564013465.647 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346624 psu 2019-07-25T00:11:06.651Z,1564013466.651 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346626 psu 2019-07-25T00:11:07.643Z,1564013467.643 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346566 psu 2019-07-25T00:11:07.864Z,1564013467.864 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1564013440.000000 second 2019-07-25T00:11:08.108Z,1564013468.108 [profile_station:NeedComms:C] Stopped 2019-07-25T00:11:08.108Z,1564013468.108 [profile_station:NeedComms:D] Running Loop=1 2019-07-25T00:11:08.491Z,1564013468.491 [profile_station:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-07-25T00:11:08.651Z,1564013468.651 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346510 psu 2019-07-25T00:11:09.121Z,1564013469.121 [DataOverHttps](INFO): Sending 201 bytes from file Logs/20190725T000219/Courier0007.lzma 2019-07-25T00:11:09.612Z,1564013469.612 [DataOverHttps](INFO): Moved sent file to Logs/20190725T000219/Courier0007.lzma.bak 2019-07-25T00:11:09.613Z,1564013469.613 [DataOverHttps](INFO): SBD MOMSN=11473396 2019-07-25T00:11:09.651Z,1564013469.651 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346506 psu 2019-07-25T00:11:10.659Z,1564013470.659 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346454 psu 2019-07-25T00:11:11.659Z,1564013471.659 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346384 psu 2019-07-25T00:11:12.652Z,1564013472.652 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346388 psu 2019-07-25T00:11:13.656Z,1564013473.656 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346609 psu 2019-07-25T00:11:14.660Z,1564013474.660 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346329 psu 2019-07-25T00:11:15.664Z,1564013475.664 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346268 psu 2019-07-25T00:11:16.668Z,1564013476.668 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346271 psu 2019-07-25T00:11:17.040Z,1564013477.040 [CommandLine](IMPORTANT): got command show stack 2019-07-25T00:11:17.040Z,1564013477.040 [CommandLine](IMPORTANT): Behavior Stack: 2019-07-25T00:11:17.041Z,1564013477.041 [profile_station:Science](IMPORTANT): Priority 0: profile_station:Science:A 2019-07-25T00:11:17.041Z,1564013477.041 [profile_station:Science](IMPORTANT): Priority 1: profile_station:Science:C 2019-07-25T00:11:17.042Z,1564013477.042 [profile_station:Science](IMPORTANT): Priority 2: profile_station:Science:D 2019-07-25T00:11:17.042Z,1564013477.042 [profile_station:Science](IMPORTANT): Priority 3: profile_station:Science:G 2019-07-25T00:11:17.042Z,1564013477.042 [profile_station:Science:PeakDetectChl](IMPORTANT): Priority 4: profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth 2019-07-25T00:11:17.043Z,1564013477.043 [profile_station:NeedComms](IMPORTANT): Priority 5: profile_station:NeedComms:B.GoToSurface 2019-07-25T00:11:17.043Z,1564013477.043 [profile_station:NeedComms](IMPORTANT): Priority 6: profile_station:NeedComms:D 2019-07-25T00:11:17.043Z,1564013477.043 [profile_station:StandardEnvelopes](IMPORTANT): Priority 7: profile_station:StandardEnvelopes:A.AltitudeEnvelope 2019-07-25T00:11:17.044Z,1564013477.044 [profile_station:StandardEnvelopes](IMPORTANT): Priority 8: profile_station:StandardEnvelopes:B.DepthEnvelope 2019-07-25T00:11:17.044Z,1564013477.044 [profile_station:StandardEnvelopes](IMPORTANT): Priority 9: profile_station:StandardEnvelopes:C.OffshoreEnvelope 2019-07-25T00:11:17.044Z,1564013477.044 [profile_station](IMPORTANT): Priority 10: profile_station:I.Pitch 2019-07-25T00:11:17.044Z,1564013477.044 [profile_station](IMPORTANT): Priority 11: profile_station:J.Buoyancy 2019-07-25T00:11:17.045Z,1564013477.045 [profile_station](IMPORTANT): Priority 12: profile_station:K.SetSpeed 2019-07-25T00:11:17.045Z,1564013477.045 [profile_station](IMPORTANT): Priority 13: profile_station:L.DepthEnvelope 2019-07-25T00:11:17.045Z,1564013477.045 [profile_station](IMPORTANT): Priority 14: profile_station:M.AltitudeEnvelope 2019-07-25T00:11:17.046Z,1564013477.046 [profile_station](IMPORTANT): Priority 15: profile_station:N.YoYo 2019-07-25T00:11:17.672Z,1564013477.672 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346215 psu 2019-07-25T00:11:18.676Z,1564013478.676 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346156 psu 2019-07-25T00:11:19.680Z,1564013479.680 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346156 psu 2019-07-25T00:11:20.684Z,1564013480.684 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346099 psu 2019-07-25T00:11:21.688Z,1564013481.688 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346098 psu 2019-07-25T00:11:22.692Z,1564013482.692 [CTD_Seabird](ERROR): Salinity reading out of range: 0.346041 psu 2019-07-25T00:11:22.795Z,1564013482.795 [CommandLine](IMPORTANT): got command show variable elevatorAngle 2019-07-25T00:11:23.072Z,1564013483.072 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleAction (radian) 2019-07-25T00:11:23.082Z,1564013483.082 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleCmd (radian) 2019-07-25T00:11:23.493Z,1564013483.493 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190725T000219/Courier0010.lzma 2019-07-25T00:11:23.696Z,1564013483.696 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345987 psu 2019-07-25T00:11:24.301Z,1564013484.301 [DataOverHttps](INFO): Moved sent file to Logs/20190725T000219/Courier0010.lzma.bak 2019-07-25T00:11:24.301Z,1564013484.301 [DataOverHttps](INFO): SBD MOMSN=11473398 2019-07-25T00:11:24.700Z,1564013484.700 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345983 psu 2019-07-25T00:11:25.704Z,1564013485.704 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345925 psu 2019-07-25T00:11:26.708Z,1564013486.708 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345863 psu 2019-07-25T00:11:27.712Z,1564013487.712 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345863 psu 2019-07-25T00:11:28.716Z,1564013488.716 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345856 psu 2019-07-25T00:11:29.720Z,1564013489.720 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345805 psu 2019-07-25T00:11:30.724Z,1564013490.724 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345802 psu 2019-07-25T00:11:31.728Z,1564013491.728 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345744 psu 2019-07-25T00:11:32.732Z,1564013492.732 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345687 psu 2019-07-25T00:11:33.032Z,1564013493.032 [CommandLine](IMPORTANT): got command get VerticalControl.elevatorAngleAction degree 2019-07-25T00:11:33.032Z,1564013493.032 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleAction 0.000000 arcdeg 2019-07-25T00:11:33.736Z,1564013493.736 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345631 psu 2019-07-25T00:11:34.741Z,1564013494.741 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345634 psu 2019-07-25T00:11:35.744Z,1564013495.744 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345589 psu 2019-07-25T00:11:36.748Z,1564013496.748 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345580 psu 2019-07-25T00:11:36.901Z,1564013496.901 [CommandLine](IMPORTANT): got command show stack 2019-07-25T00:11:36.901Z,1564013496.901 [CommandLine](IMPORTANT): Behavior Stack: 2019-07-25T00:11:36.902Z,1564013496.902 [profile_station:Science](IMPORTANT): Priority 0: profile_station:Science:A 2019-07-25T00:11:36.902Z,1564013496.902 [profile_station:Science](IMPORTANT): Priority 1: profile_station:Science:C 2019-07-25T00:11:36.903Z,1564013496.903 [profile_station:Science](IMPORTANT): Priority 2: profile_station:Science:D 2019-07-25T00:11:36.903Z,1564013496.903 [profile_station:Science](IMPORTANT): Priority 3: profile_station:Science:G 2019-07-25T00:11:36.903Z,1564013496.903 [profile_station:Science:PeakDetectChl](IMPORTANT): Priority 4: profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth 2019-07-25T00:11:36.904Z,1564013496.904 [profile_station:NeedComms](IMPORTANT): Priority 5: profile_station:NeedComms:B.GoToSurface 2019-07-25T00:11:36.904Z,1564013496.904 [profile_station:NeedComms](IMPORTANT): Priority 6: profile_station:NeedComms:D 2019-07-25T00:11:36.904Z,1564013496.904 [profile_station:StandardEnvelopes](IMPORTANT): Priority 7: profile_station:StandardEnvelopes:A.AltitudeEnvelope 2019-07-25T00:11:36.904Z,1564013496.904 [profile_station:StandardEnvelopes](IMPORTANT): Priority 8: profile_station:StandardEnvelopes:B.DepthEnvelope 2019-07-25T00:11:36.905Z,1564013496.905 [profile_station:StandardEnvelopes](IMPORTANT): Priority 9: profile_station:StandardEnvelopes:C.OffshoreEnvelope 2019-07-25T00:11:36.905Z,1564013496.905 [profile_station](IMPORTANT): Priority 10: profile_station:I.Pitch 2019-07-25T00:11:36.905Z,1564013496.905 [profile_station](IMPORTANT): Priority 11: profile_station:J.Buoyancy 2019-07-25T00:11:36.906Z,1564013496.906 [profile_station](IMPORTANT): Priority 12: profile_station:K.SetSpeed 2019-07-25T00:11:36.906Z,1564013496.906 [profile_station](IMPORTANT): Priority 13: profile_station:L.DepthEnvelope 2019-07-25T00:11:36.906Z,1564013496.906 [profile_station](IMPORTANT): Priority 14: profile_station:M.AltitudeEnvelope 2019-07-25T00:11:36.907Z,1564013496.907 [profile_station](IMPORTANT): Priority 15: profile_station:N.YoYo 2019-07-25T00:11:37.752Z,1564013497.752 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345530 psu 2019-07-25T00:11:38.756Z,1564013498.756 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345469 psu 2019-07-25T00:11:39.363Z,1564013499.363 [DataOverHttps](INFO): Sending 1315 bytes from file Logs/20190725T000219/Express0008.lzma 2019-07-25T00:11:39.760Z,1564013499.760 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345464 psu 2019-07-25T00:11:40.168Z,1564013500.168 [DataOverHttps](INFO): Moved sent file to Logs/20190725T000219/Express0008.lzma.bak 2019-07-25T00:11:40.168Z,1564013500.168 [DataOverHttps](INFO): SBD MOMSN=11473400 2019-07-25T00:11:40.764Z,1564013500.764 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345402 psu 2019-07-25T00:11:41.768Z,1564013501.768 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345344 psu 2019-07-25T00:11:42.773Z,1564013502.773 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345282 psu 2019-07-25T00:11:43.778Z,1564013503.778 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345283 psu 2019-07-25T00:11:44.782Z,1564013504.782 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345231 psu 2019-07-25T00:11:45.785Z,1564013505.785 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345167 psu 2019-07-25T00:11:46.033Z,1564013506.033 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-07-25T00:11:46.033Z,1564013506.033 [DVL_micro] Data Fault, FailCount= 1 2019-07-25T00:11:46.033Z,1564013506.033 [DVL_micro](ERROR): Data Fault 2019-07-25T00:11:46.125Z,1564013506.125 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-07-25T00:11:46.498Z,1564013506.498 [DVL_micro](INFO): uninitialize:Powering down 2019-07-25T00:11:46.789Z,1564013506.789 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345167 psu 2019-07-25T00:11:47.279Z,1564013507.279 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-07-25T00:11:47.279Z,1564013507.279 [DVL_micro] No Fault, FailCount= 1 2019-07-25T00:11:47.646Z,1564013507.646 [DVL_micro](INFO): Initializing 2019-07-25T00:11:47.793Z,1564013507.793 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345166 psu 2019-07-25T00:11:48.798Z,1564013508.798 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345159 psu 2019-07-25T00:11:49.800Z,1564013509.800 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345099 psu 2019-07-25T00:11:50.804Z,1564013510.804 [CTD_Seabird](ERROR): Salinity reading out of range: 0.345048 psu 2019-07-25T00:11:51.808Z,1564013511.808 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344978 psu 2019-07-25T00:11:52.812Z,1564013512.812 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344913 psu 2019-07-25T00:11:53.816Z,1564013513.816 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344909 psu 2019-07-25T00:11:54.419Z,1564013514.419 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1564013440.000000 second 2019-07-25T00:11:54.821Z,1564013514.821 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344852 psu 2019-07-25T00:11:54.865Z,1564013514.865 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20190725T000219/Express0011.lzma 2019-07-25T00:11:55.671Z,1564013515.671 [DataOverHttps](INFO): Moved sent file to Logs/20190725T000219/Express0011.lzma.bak 2019-07-25T00:11:55.672Z,1564013515.672 [DataOverHttps](INFO): SBD MOMSN=11473447 2019-07-25T00:11:55.824Z,1564013515.824 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344846 psu 2019-07-25T00:11:56.156Z,1564013516.156 [profile_station:NeedComms:D] Stopped 2019-07-25T00:11:56.156Z,1564013516.156 [profile_station:NeedComms:E] Running Loop=1 2019-07-25T00:11:56.548Z,1564013516.548 [profile_station:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-07-25T00:11:56.828Z,1564013516.828 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344846 psu 2019-07-25T00:11:57.379Z,1564013517.379 [DVL_micro](ERROR): only read 44 of 46 data items 2019-07-25T00:11:57.379Z,1564013517.379 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 123 134 37 246 2 3 2 2 114.8 -149.5 145.6 2 -135.2 131.4 145.6 2 114 -149 145 2 -135 131.05 -1.55 188.3 -3.0 18.9 0.005 35.0 1489 93 2019-07-25T00:11:57.832Z,1564013517.832 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344795 psu 2019-07-25T00:11:58.836Z,1564013518.836 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344747 psu 2019-07-25T00:11:59.840Z,1564013519.840 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344757 psu 2019-07-25T00:12:00.844Z,1564013520.844 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344698 psu 2019-07-25T00:12:01.848Z,1564013521.848 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344642 psu 2019-07-25T00:12:02.852Z,1564013522.852 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344584 psu 2019-07-25T00:12:03.856Z,1564013523.856 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344577 psu 2019-07-25T00:12:04.860Z,1564013524.860 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344519 psu 2019-07-25T00:12:05.864Z,1564013525.864 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344454 psu 2019-07-25T00:12:06.868Z,1564013526.868 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344446 psu 2019-07-25T00:12:07.087Z,1564013527.087 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool 2019-07-25T00:12:07.872Z,1564013527.872 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344388 psu 2019-07-25T00:12:08.876Z,1564013528.876 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344330 psu 2019-07-25T00:12:09.880Z,1564013529.880 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344325 psu 2019-07-25T00:12:10.884Z,1564013530.884 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344264 psu 2019-07-25T00:12:11.888Z,1564013531.888 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344258 psu 2019-07-25T00:12:12.892Z,1564013532.892 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344196 psu 2019-07-25T00:12:13.896Z,1564013533.896 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344141 psu 2019-07-25T00:12:14.899Z,1564013534.899 [CTD_Seabird](ERROR): Failed to parse device response: 0 2019-07-25T00:12:14.947Z,1564013534.947 [CommandLine](IMPORTANT): got command show variable elevatorAngle 2019-07-25T00:12:15.070Z,1564013535.070 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleAction (radian) 2019-07-25T00:12:15.071Z,1564013535.071 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleCmd (radian) 2019-07-25T00:12:15.904Z,1564013535.904 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344082 psu 2019-07-25T00:12:16.908Z,1564013536.908 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344079 psu 2019-07-25T00:12:17.912Z,1564013537.912 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344018 psu 2019-07-25T00:12:18.916Z,1564013538.916 [CTD_Seabird](ERROR): Salinity reading out of range: 0.344008 psu 2019-07-25T00:12:19.920Z,1564013539.920 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343953 psu 2019-07-25T00:12:20.924Z,1564013540.924 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343945 psu 2019-07-25T00:12:21.928Z,1564013541.928 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343888 psu 2019-07-25T00:12:22.932Z,1564013542.932 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343885 psu 2019-07-25T00:12:23.936Z,1564013543.936 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343826 psu 2019-07-25T00:12:24.943Z,1564013544.943 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343829 psu 2019-07-25T00:12:25.944Z,1564013545.944 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343769 psu 2019-07-25T00:12:26.948Z,1564013546.948 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343769 psu 2019-07-25T00:12:27.952Z,1564013547.952 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343713 psu 2019-07-25T00:12:28.567Z,1564013548.567 [CommandLine](IMPORTANT): got command get VerticalControl.elevatorAngleAction degree 2019-07-25T00:12:28.568Z,1564013548.568 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleAction 0.000000 arcdeg 2019-07-25T00:12:28.956Z,1564013548.956 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343651 psu 2019-07-25T00:12:29.960Z,1564013549.960 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343594 psu 2019-07-25T00:12:30.964Z,1564013550.964 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343536 psu 2019-07-25T00:12:31.968Z,1564013551.968 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343524 psu 2019-07-25T00:12:32.972Z,1564013552.972 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343523 psu 2019-07-25T00:12:33.976Z,1564013553.976 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343465 psu 2019-07-25T00:12:34.980Z,1564013554.980 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343467 psu 2019-07-25T00:12:35.989Z,1564013555.989 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343464 psu 2019-07-25T00:12:36.988Z,1564013556.988 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343403 psu 2019-07-25T00:12:37.995Z,1564013557.995 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343408 psu 2019-07-25T00:12:38.996Z,1564013558.996 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343465 psu 2019-07-25T00:12:40.002Z,1564013560.002 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343463 psu 2019-07-25T00:12:41.004Z,1564013561.004 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343404 psu 2019-07-25T00:12:42.008Z,1564013562.008 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343404 psu 2019-07-25T00:12:43.012Z,1564013563.012 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343341 psu 2019-07-25T00:12:44.016Z,1564013564.016 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343344 psu 2019-07-25T00:12:45.020Z,1564013565.020 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343284 psu 2019-07-25T00:12:46.025Z,1564013566.025 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343228 psu 2019-07-25T00:12:47.029Z,1564013567.029 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343176 psu 2019-07-25T00:12:47.079Z,1564013567.079 [CommandLine](IMPORTANT): got command show stack 2019-07-25T00:12:47.079Z,1564013567.079 [CommandLine](IMPORTANT): Behavior Stack: 2019-07-25T00:12:47.080Z,1564013567.080 [profile_station:Science](IMPORTANT): Priority 0: profile_station:Science:A 2019-07-25T00:12:47.080Z,1564013567.080 [profile_station:Science](IMPORTANT): Priority 1: profile_station:Science:C 2019-07-25T00:12:47.081Z,1564013567.081 [profile_station:Science](IMPORTANT): Priority 2: profile_station:Science:D 2019-07-25T00:12:47.081Z,1564013567.081 [profile_station:Science](IMPORTANT): Priority 3: profile_station:Science:G 2019-07-25T00:12:47.081Z,1564013567.081 [profile_station:Science:PeakDetectChl](IMPORTANT): Priority 4: profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth 2019-07-25T00:12:47.082Z,1564013567.082 [profile_station:NeedComms](IMPORTANT): Priority 5: profile_station:NeedComms:B.GoToSurface 2019-07-25T00:12:47.083Z,1564013567.083 [profile_station:NeedComms](IMPORTANT): Priority 6: profile_station:NeedComms:E 2019-07-25T00:12:47.083Z,1564013567.083 [profile_station:StandardEnvelopes](IMPORTANT): Priority 7: profile_station:StandardEnvelopes:A.AltitudeEnvelope 2019-07-25T00:12:47.083Z,1564013567.083 [profile_station:StandardEnvelopes](IMPORTANT): Priority 8: profile_station:StandardEnvelopes:B.DepthEnvelope 2019-07-25T00:12:47.084Z,1564013567.084 [profile_station:StandardEnvelopes](IMPORTANT): Priority 9: profile_station:StandardEnvelopes:C.OffshoreEnvelope 2019-07-25T00:12:47.084Z,1564013567.084 [profile_station](IMPORTANT): Priority 10: profile_station:I.Pitch 2019-07-25T00:12:47.084Z,1564013567.084 [profile_station](IMPORTANT): Priority 11: profile_station:J.Buoyancy 2019-07-25T00:12:47.085Z,1564013567.085 [profile_station](IMPORTANT): Priority 12: profile_station:K.SetSpeed 2019-07-25T00:12:47.085Z,1564013567.085 [profile_station](IMPORTANT): Priority 13: profile_station:L.DepthEnvelope 2019-07-25T00:12:47.085Z,1564013567.085 [profile_station](IMPORTANT): Priority 14: profile_station:M.AltitudeEnvelope 2019-07-25T00:12:47.085Z,1564013567.085 [profile_station](IMPORTANT): Priority 15: profile_station:N.YoYo 2019-07-25T00:12:48.033Z,1564013568.033 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343183 psu 2019-07-25T00:12:49.037Z,1564013569.037 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343130 psu 2019-07-25T00:12:50.040Z,1564013570.040 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343073 psu 2019-07-25T00:12:51.045Z,1564013571.045 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343084 psu 2019-07-25T00:12:52.048Z,1564013572.048 [CTD_Seabird](ERROR): Salinity reading out of range: 0.343032 psu 2019-07-25T00:12:53.052Z,1564013573.052 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342980 psu 2019-07-25T00:12:54.056Z,1564013574.056 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342928 psu 2019-07-25T00:12:55.060Z,1564013575.060 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342876 psu 2019-07-25T00:12:55.519Z,1564013575.519 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:12:55.519Z,1564013575.519 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 45 248 95 1305 2 3 2 2 -66.7 -1410.7 456.5 2 -137.5 1405.2 -66 -1410 456 2 -137 1405 456 2 0.94 -1.61 188.3 -3.0 18.9 0.005 35.0 1489 93 2019-07-25T00:12:56.064Z,1564013576.064 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342872 psu 2019-07-25T00:12:57.068Z,1564013577.068 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342817 psu 2019-07-25T00:12:58.072Z,1564013578.072 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342759 psu 2019-07-25T00:12:59.076Z,1564013579.076 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342704 psu 2019-07-25T00:13:00.080Z,1564013580.080 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342703 psu 2019-07-25T00:13:01.084Z,1564013581.084 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342648 psu 2019-07-25T00:13:02.088Z,1564013582.088 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342596 psu 2019-07-25T00:13:03.092Z,1564013583.092 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342715 psu 2019-07-25T00:13:04.096Z,1564013584.096 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342612 psu 2019-07-25T00:13:05.100Z,1564013585.100 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342495 psu 2019-07-25T00:13:06.104Z,1564013586.104 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342391 psu 2019-07-25T00:13:07.108Z,1564013587.108 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342393 psu 2019-07-25T00:13:08.112Z,1564013588.112 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342344 psu 2019-07-25T00:13:09.116Z,1564013589.116 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342285 psu 2019-07-25T00:13:10.120Z,1564013590.120 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342236 psu 2019-07-25T00:13:11.124Z,1564013591.124 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342228 psu 2019-07-25T00:13:12.128Z,1564013592.128 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342177 psu 2019-07-25T00:13:13.132Z,1564013593.132 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342183 psu 2019-07-25T00:13:14.136Z,1564013594.136 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342127 psu 2019-07-25T00:13:15.140Z,1564013595.140 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342073 psu 2019-07-25T00:13:16.147Z,1564013596.147 [CTD_Seabird](ERROR): Salinity reading out of range: 0.342016 psu 2019-07-25T00:13:17.150Z,1564013597.150 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341963 psu 2019-07-25T00:13:18.153Z,1564013598.153 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341976 psu 2019-07-25T00:13:19.157Z,1564013599.157 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341925 psu 2019-07-25T00:13:20.161Z,1564013600.161 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341872 psu 2019-07-25T00:13:21.165Z,1564013601.165 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341821 psu 2019-07-25T00:13:22.168Z,1564013602.168 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341827 psu 2019-07-25T00:13:22.711Z,1564013602.711 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool 2019-07-25T00:13:23.172Z,1564013603.172 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341774 psu 2019-07-25T00:13:24.176Z,1564013604.176 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341721 psu 2019-07-25T00:13:25.180Z,1564013605.180 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341714 psu 2019-07-25T00:13:26.184Z,1564013606.184 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341658 psu 2019-07-25T00:13:27.188Z,1564013607.188 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341604 psu 2019-07-25T00:13:28.192Z,1564013608.192 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341547 psu 2019-07-25T00:13:29.196Z,1564013609.196 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341494 psu 2019-07-25T00:13:30.200Z,1564013610.200 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341491 psu 2019-07-25T00:13:30.837Z,1564013610.837 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 0.000000 bool 2019-07-25T00:13:31.204Z,1564013611.204 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341438 psu 2019-07-25T00:13:32.208Z,1564013612.208 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341375 psu 2019-07-25T00:13:33.212Z,1564013613.212 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341373 psu 2019-07-25T00:13:34.216Z,1564013614.216 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341315 psu 2019-07-25T00:13:35.220Z,1564013615.220 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341259 psu 2019-07-25T00:13:36.224Z,1564013616.224 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341196 psu 2019-07-25T00:13:37.228Z,1564013617.228 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341187 psu 2019-07-25T00:13:38.232Z,1564013618.232 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341127 psu 2019-07-25T00:13:38.941Z,1564013618.941 [CommandLine](IMPORTANT): got command set NAL9602.platform_communications 1.000000 bool 2019-07-25T00:13:39.236Z,1564013619.236 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341069 psu 2019-07-25T00:13:40.240Z,1564013620.240 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341063 psu 2019-07-25T00:13:41.244Z,1564013621.244 [CTD_Seabird](ERROR): Salinity reading out of range: 0.341010 psu 2019-07-25T00:13:42.248Z,1564013622.248 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340946 psu 2019-07-25T00:13:43.252Z,1564013623.252 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340943 psu 2019-07-25T00:13:44.256Z,1564013624.256 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340879 psu 2019-07-25T00:13:45.260Z,1564013625.260 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340820 psu 2019-07-25T00:13:46.264Z,1564013626.264 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340808 psu 2019-07-25T00:13:47.268Z,1564013627.268 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340744 psu 2019-07-25T00:13:48.272Z,1564013628.272 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340675 psu 2019-07-25T00:13:49.277Z,1564013629.277 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340666 psu 2019-07-25T00:13:50.281Z,1564013630.281 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340603 psu 2019-07-25T00:13:51.285Z,1564013631.285 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340536 psu 2019-07-25T00:13:52.289Z,1564013632.289 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340530 psu 2019-07-25T00:13:52.796Z,1564013632.796 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1564013568.000000 second 2019-07-25T00:13:52.968Z,1564013632.968 [profile_station:NeedComms:E] Stopped 2019-07-25T00:13:52.969Z,1564013632.969 [profile_station:NeedComms](INFO): Completed profile_station:NeedComms 2019-07-25T00:13:52.969Z,1564013632.969 [profile_station:NeedComms] Stopped 2019-07-25T00:13:52.969Z,1564013632.969 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms 2019-07-25T00:13:52.969Z,1564013632.969 [profile_station:NeedComms:B.GoToSurface] Stopped 2019-07-25T00:13:52.969Z,1564013632.969 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-25T00:13:53.293Z,1564013633.293 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340462 psu 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:StartingMission](INFO): Completed profile_station:StartingMission 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:StartingMission] Stopped 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:StartingMission](DEBUG): Aggregate::uninitialize profile_station:StartingMission 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:CircleWrapper] Running Loop=1 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:CircleWrapper:A] Running Loop=1 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2019-07-25T00:13:53.377Z,1564013633.377 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2019-07-25T00:13:53.391Z,1564013633.391 [Reporter](INFO): SpeedControl.speedCmd 1.000000 m/s 2019-07-25T00:13:53.797Z,1564013633.797 [profile_station:CircleWrapper:A] Running Loop=1 2019-07-25T00:13:54.296Z,1564013634.296 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340450 psu 2019-07-25T00:13:55.300Z,1564013635.300 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340445 psu 2019-07-25T00:13:56.304Z,1564013636.304 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340375 psu 2019-07-25T00:13:57.308Z,1564013637.308 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340312 psu 2019-07-25T00:13:58.337Z,1564013638.337 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340305 psu 2019-07-25T00:13:59.336Z,1564013639.336 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340189 psu 2019-07-25T00:14:00.341Z,1564013640.341 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340236 psu 2019-07-25T00:14:01.344Z,1564013641.344 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340173 psu 2019-07-25T00:14:02.349Z,1564013642.349 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340168 psu 2019-07-25T00:14:03.352Z,1564013643.352 [CTD_Seabird](ERROR): Salinity reading out of range: 0.340054 psu 2019-07-25T00:14:03.419Z,1564013643.419 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:14:03.419Z,1564013643.419 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 119 124 102 184 2 3 2 2 22.7 -80.1 142.6 2 -33.6 76.2 142.6 2 22 -80 142 2 -33 76 142 2 1.11 -1.51 188.0 -3.0 19.0 00 1489 108 2019-07-25T00:14:04.356Z,1564013644.356 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339999 psu 2019-07-25T00:14:05.360Z,1564013645.360 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339884 psu 2019-07-25T00:14:06.372Z,1564013646.372 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339878 psu 2019-07-25T00:14:07.368Z,1564013647.368 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339820 psu 2019-07-25T00:14:08.372Z,1564013648.372 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339812 psu 2019-07-25T00:14:08.607Z,1564013648.607 [CommandLine](IMPORTANT): got command get VerticalControl.elevatorAngleAction degree 2019-07-25T00:14:08.607Z,1564013648.607 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleAction 6.784568 arcdeg 2019-07-25T00:14:09.376Z,1564013649.376 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339754 psu 2019-07-25T00:14:10.380Z,1564013650.380 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339691 psu 2019-07-25T00:14:11.384Z,1564013651.384 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339628 psu 2019-07-25T00:14:12.388Z,1564013652.388 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339628 psu 2019-07-25T00:14:13.392Z,1564013653.392 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339569 psu 2019-07-25T00:14:14.396Z,1564013654.396 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339569 psu 2019-07-25T00:14:15.400Z,1564013655.400 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339563 psu 2019-07-25T00:14:16.369Z,1564013656.369 [DVL_micro](ERROR): checksum mismatch: reported96 , calculated:126 2019-07-25T00:14:16.370Z,1564013656.370 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 108 452 174 210 2 3 2 2 -88.154.5 2 131.6 -307.8 254.5 2 -88 323 254 2 131 -307 254 2 1.18 -1.45 187.9 -3.0 19.0 0.005 35.0 1489 96 2019-07-25T00:14:16.404Z,1564013656.404 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339506 psu 2019-07-25T00:14:17.408Z,1564013657.408 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339450 psu 2019-07-25T00:14:18.412Z,1564013658.412 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339447 psu 2019-07-25T00:14:19.416Z,1564013659.416 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339444 psu 2019-07-25T00:14:20.420Z,1564013660.420 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339328 psu 2019-07-25T00:14:21.424Z,1564013661.424 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339322 psu 2019-07-25T00:14:22.428Z,1564013662.428 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339260 psu 2019-07-25T00:14:23.432Z,1564013663.432 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339199 psu 2019-07-25T00:14:24.436Z,1564013664.436 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339248 psu 2019-07-25T00:14:25.441Z,1564013665.441 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339182 psu 2019-07-25T00:14:26.444Z,1564013666.444 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339122 psu 2019-07-25T00:14:27.448Z,1564013667.448 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339123 psu 2019-07-25T00:14:28.477Z,1564013668.477 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339120 psu 2019-07-25T00:14:29.476Z,1564013669.476 [CTD_Seabird](ERROR): Salinity reading out of range: 0.339059 psu 2019-07-25T00:14:30.480Z,1564013670.480 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338998 psu 2019-07-25T00:14:31.485Z,1564013671.485 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338940 psu 2019-07-25T00:14:32.119Z,1564013672.119 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-07-25T00:14:32.488Z,1564013672.488 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338938 psu 2019-07-25T00:14:33.492Z,1564013673.492 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338874 psu 2019-07-25T00:14:34.496Z,1564013674.496 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338817 psu 2019-07-25T00:14:35.500Z,1564013675.500 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338806 psu 2019-07-25T00:14:36.504Z,1564013676.504 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338744 psu 2019-07-25T00:14:37.516Z,1564013677.516 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338743 psu 2019-07-25T00:14:38.512Z,1564013678.512 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338745 psu 2019-07-25T00:14:39.516Z,1564013679.516 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338684 psu 2019-07-25T00:14:40.520Z,1564013680.520 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338692 psu 2019-07-25T00:14:41.527Z,1564013681.527 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338690 psu 2019-07-25T00:14:42.530Z,1564013682.530 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338648 psu 2019-07-25T00:14:43.556Z,1564013683.556 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338649 psu 2019-07-25T00:14:44.505Z,1564013684.505 [CommandLine](IMPORTANT): got command get VerticalControl.elevatorAngleAction degree 2019-07-25T00:14:44.506Z,1564013684.506 [CommandLine](IMPORTANT): VerticalControl.elevatorAngleAction 11.587016 arcdeg 2019-07-25T00:14:44.537Z,1564013684.537 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338599 psu 2019-07-25T00:14:45.465Z,1564013685.465 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:14:45.465Z,1564013685.465 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 162 191 75 295 2 3 2 2 116.1 -138.8 194.9 2 -135.5 119.9 194.9 2 116 -138 194 2 -135 119 194 2 0.66 -1.64 188.6 -3.0 19 35.0 1489 90 2019-07-25T00:14:45.541Z,1564013685.541 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338603 psu 2019-07-25T00:14:46.545Z,1564013686.545 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338607 psu 2019-07-25T00:14:47.548Z,1564013687.548 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338555 psu 2019-07-25T00:14:48.552Z,1564013688.552 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338557 psu 2019-07-25T00:14:49.557Z,1564013689.557 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338557 psu 2019-07-25T00:14:50.560Z,1564013690.560 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338496 psu 2019-07-25T00:14:51.564Z,1564013691.564 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338442 psu 2019-07-25T00:14:51.905Z,1564013691.905 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-07-25T00:14:51.905Z,1564013691.905 [DVL_micro] Data Fault, FailCount= 1 2019-07-25T00:14:51.905Z,1564013691.905 [DVL_micro](ERROR): Data Fault 2019-07-25T00:14:51.979Z,1564013691.979 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-07-25T00:14:52.386Z,1564013692.386 [DVL_micro](INFO): uninitialize:Powering down 2019-07-25T00:14:52.568Z,1564013692.568 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338436 psu 2019-07-25T00:14:53.254Z,1564013693.254 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-07-25T00:14:53.254Z,1564013693.254 [DVL_micro] No Fault, FailCount= 1 2019-07-25T00:14:53.541Z,1564013693.541 [DVL_micro](INFO): Initializing 2019-07-25T00:14:53.572Z,1564013693.572 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338379 psu 2019-07-25T00:14:54.577Z,1564013694.577 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338324 psu 2019-07-25T00:14:55.581Z,1564013695.581 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338327 psu 2019-07-25T00:14:56.585Z,1564013696.585 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338278 psu 2019-07-25T00:14:57.589Z,1564013697.589 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338283 psu 2019-07-25T00:14:58.593Z,1564013698.593 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338241 psu 2019-07-25T00:14:59.597Z,1564013699.597 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338243 psu 2019-07-25T00:15:00.601Z,1564013700.601 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338192 psu 2019-07-25T00:15:01.604Z,1564013701.604 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338192 psu 2019-07-25T00:15:02.608Z,1564013702.608 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338080 psu 2019-07-25T00:15:02.818Z,1564013702.818 [NAL9602](INFO): Not Powering down - fast GPS 2019-07-25T00:15:03.612Z,1564013703.612 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338021 psu 2019-07-25T00:15:04.616Z,1564013704.616 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338075 psu 2019-07-25T00:15:05.624Z,1564013705.624 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338017 psu 2019-07-25T00:15:06.628Z,1564013706.628 [CTD_Seabird](ERROR): Salinity reading out of range: 0.338018 psu 2019-07-25T00:15:07.632Z,1564013707.632 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337958 psu 2019-07-25T00:15:08.636Z,1564013708.636 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337962 psu 2019-07-25T00:15:09.640Z,1564013709.640 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337905 psu 2019-07-25T00:15:10.644Z,1564013710.644 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337910 psu 2019-07-25T00:15:11.648Z,1564013711.648 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337906 psu 2019-07-25T00:15:12.652Z,1564013712.652 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337851 psu 2019-07-25T00:15:13.656Z,1564013713.656 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337854 psu 2019-07-25T00:15:14.662Z,1564013714.662 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337795 psu 2019-07-25T00:15:15.669Z,1564013715.669 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337796 psu 2019-07-25T00:15:16.668Z,1564013716.668 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337740 psu 2019-07-25T00:15:17.676Z,1564013717.676 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337794 psu 2019-07-25T00:15:18.676Z,1564013718.676 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337730 psu 2019-07-25T00:15:19.682Z,1564013719.682 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337672 psu 2019-07-25T00:15:20.684Z,1564013720.684 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337665 psu 2019-07-25T00:15:21.689Z,1564013721.689 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337607 psu 2019-07-25T00:15:22.692Z,1564013722.692 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337600 psu 2019-07-25T00:15:23.697Z,1564013723.697 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337594 psu 2019-07-25T00:15:24.700Z,1564013724.700 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337586 psu 2019-07-25T00:15:25.704Z,1564013725.704 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337522 psu 2019-07-25T00:15:26.708Z,1564013726.708 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337521 psu 2019-07-25T00:15:27.712Z,1564013727.712 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337460 psu 2019-07-25T00:15:28.716Z,1564013728.716 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337464 psu 2019-07-25T00:15:29.720Z,1564013729.720 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337469 psu 2019-07-25T00:15:30.724Z,1564013730.724 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337409 psu 2019-07-25T00:15:31.728Z,1564013731.728 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337420 psu 2019-07-25T00:15:32.733Z,1564013732.733 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337354 psu 2019-07-25T00:15:33.736Z,1564013733.736 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337355 psu 2019-07-25T00:15:34.740Z,1564013734.740 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337299 psu 2019-07-25T00:15:35.744Z,1564013735.744 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337297 psu 2019-07-25T00:15:36.748Z,1564013736.748 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337243 psu 2019-07-25T00:15:37.752Z,1564013737.752 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337238 psu 2019-07-25T00:15:38.756Z,1564013738.756 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337179 psu 2019-07-25T00:15:39.760Z,1564013739.760 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337176 psu 2019-07-25T00:15:40.764Z,1564013740.764 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337118 psu 2019-07-25T00:15:41.768Z,1564013741.768 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337109 psu 2019-07-25T00:15:42.046Z,1564013742.046 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:15:42.046Z,1564013742.046 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 162 187 251 200 2 3 2 2 -118.8 -17.4 215.7 2 114.9 34.8 215.7 2 -118 -17 215 2 114 34 215 2 0.79 -1.64 18 19.0 0.005 35.0 1489 96 2019-07-25T00:15:42.772Z,1564013742.772 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337104 psu 2019-07-25T00:15:43.776Z,1564013743.776 [CTD_Seabird](ERROR): Salinity reading out of range: 0.337039 psu 2019-07-25T00:15:44.780Z,1564013744.780 [CTD_Seabird](ERROR): Salinity reading out of range: 0.336980 psu 2019-07-25T00:15:45.784Z,1564013745.784 [CTD_Seabird](ERROR): Salinity reading out of range: 0.336910 psu 2019-07-25T00:15:46.788Z,1564013746.788 [CTD_Seabird](ERROR): Salinity reading out of range: 0.336963 psu 2019-07-25T00:15:47.792Z,1564013747.792 [CTD_Seabird](ERROR): Salinity reading out of range: 0.336900 psu 2019-07-25T00:15:48.796Z,1564013748.796 [CTD_Seabird](ERROR): Salinity reading out of range: 0.336892 psu 2019-07-25T00:15:49.800Z,1564013749.800 [CTD_Seabird](ERROR): Salinity reading out of range: 0.336883 psu 2019-07-25T00:15:50.804Z,1564013750.804 [CTD_Seabird](ERROR): Salinity reading out of range: 0.336766 psu 2019-07-25T00:15:51.808Z,1564013751.808 [CTD_Seabird](ERROR): Salinity reading out of range: 0.512599 psu 2019-07-25T00:15:52.812Z,1564013752.812 [CTD_Seabird](ERROR): Salinity reading out of range: 5.048428 psu 2019-07-25T00:15:53.816Z,1564013753.816 [CTD_Seabird](ERROR): Salinity reading out of range: 5.328614 psu 2019-07-25T00:15:54.820Z,1564013754.820 [CTD_Seabird](ERROR): Salinity reading out of range: 3.304351 psu 2019-07-25T00:15:55.824Z,1564013755.824 [CTD_Seabird](ERROR): Salinity reading out of range: 2.739941 psu 2019-07-25T00:15:56.828Z,1564013756.828 [CTD_Seabird](ERROR): Salinity reading out of range: 2.375498 psu 2019-07-25T00:15:57.832Z,1564013757.832 [CTD_Seabird](ERROR): Salinity reading out of range: 2.105053 psu 2019-07-25T00:15:58.836Z,1564013758.836 [CTD_Seabird](ERROR): Salinity reading out of range: 1.830148 psu 2019-07-25T00:15:59.840Z,1564013759.840 [CTD_Seabird](ERROR): Salinity reading out of range: 1.670817 psu 2019-07-25T00:16:00.844Z,1564013760.844 [CTD_Seabird](ERROR): Salinity reading out of range: 3.053103 psu 2019-07-25T00:16:01.849Z,1564013761.849 [CTD_Seabird](ERROR): Salinity reading out of range: 7.663259 psu 2019-07-25T00:16:02.853Z,1564013762.853 [CTD_Seabird](ERROR): Salinity reading out of range: 5.534765 psu 2019-07-25T00:16:03.857Z,1564013763.857 [CTD_Seabird](ERROR): Salinity reading out of range: 5.346126 psu 2019-07-25T00:16:04.861Z,1564013764.861 [CTD_Seabird](ERROR): Salinity reading out of range: 4.547468 psu 2019-07-25T00:16:05.865Z,1564013765.865 [CTD_Seabird](ERROR): Salinity reading out of range: 4.937781 psu 2019-07-25T00:16:06.869Z,1564013766.869 [CTD_Seabird](ERROR): Salinity reading out of range: 3.597866 psu 2019-07-25T00:16:07.872Z,1564013767.872 [CTD_Seabird](ERROR): Salinity reading out of range: 4.354227 psu 2019-07-25T00:16:08.876Z,1564013768.876 [CTD_Seabird](ERROR): Salinity reading out of range: 4.557559 psu 2019-07-25T00:16:09.880Z,1564013769.880 [CTD_Seabird](ERROR): Salinity reading out of range: 3.973872 psu 2019-07-25T00:16:10.884Z,1564013770.884 [CTD_Seabird](ERROR): Salinity reading out of range: 3.784648 psu 2019-07-25T00:16:11.888Z,1564013771.888 [CTD_Seabird](ERROR): Salinity reading out of range: 3.613987 psu 2019-07-25T00:16:12.892Z,1564013772.892 [CTD_Seabird](ERROR): Salinity reading out of range: 3.481140 psu 2019-07-25T00:16:13.898Z,1564013773.898 [CTD_Seabird](ERROR): Salinity reading out of range: 3.451234 psu 2019-07-25T00:16:14.901Z,1564013774.901 [CTD_Seabird](ERROR): Salinity reading out of range: 3.339759 psu 2019-07-25T00:16:15.905Z,1564013775.905 [CTD_Seabird](ERROR): Salinity reading out of range: 3.327499 psu 2019-07-25T00:16:16.909Z,1564013776.909 [CTD_Seabird](ERROR): Salinity reading out of range: 3.326062 psu 2019-07-25T00:16:17.913Z,1564013777.913 [CTD_Seabird](ERROR): Salinity reading out of range: 3.310905 psu 2019-07-25T00:16:18.917Z,1564013778.917 [CTD_Seabird](ERROR): Salinity reading out of range: 3.275481 psu 2019-07-25T00:16:19.920Z,1564013779.920 [CTD_Seabird](ERROR): Salinity reading out of range: 3.221726 psu 2019-07-25T00:16:20.924Z,1564013780.924 [CTD_Seabird](ERROR): Salinity reading out of range: 3.161261 psu 2019-07-25T00:16:21.928Z,1564013781.928 [CTD_Seabird](ERROR): Salinity reading out of range: 3.104678 psu 2019-07-25T00:16:22.932Z,1564013782.932 [CTD_Seabird](ERROR): Salinity reading out of range: 3.054979 psu 2019-07-25T00:16:23.936Z,1564013783.936 [CTD_Seabird](ERROR): Salinity reading out of range: 3.011923 psu 2019-07-25T00:16:24.940Z,1564013784.940 [CTD_Seabird](ERROR): Salinity reading out of range: 2.968627 psu 2019-07-25T00:16:25.944Z,1564013785.944 [CTD_Seabird](ERROR): Salinity reading out of range: 2.928076 psu 2019-07-25T00:16:26.948Z,1564013786.948 [CTD_Seabird](ERROR): Salinity reading out of range: 2.886869 psu 2019-07-25T00:16:27.952Z,1564013787.952 [CTD_Seabird](ERROR): Salinity reading out of range: 2.847469 psu 2019-07-25T00:16:28.956Z,1564013788.956 [CTD_Seabird](ERROR): Salinity reading out of range: 2.809154 psu 2019-07-25T00:16:29.960Z,1564013789.960 [CTD_Seabird](ERROR): Salinity reading out of range: 2.771885 psu 2019-07-25T00:16:30.964Z,1564013790.964 [CTD_Seabird](ERROR): Salinity reading out of range: 2.736649 psu 2019-07-25T00:16:31.968Z,1564013791.968 [CTD_Seabird](ERROR): Salinity reading out of range: 2.702882 psu 2019-07-25T00:16:32.972Z,1564013792.972 [CTD_Seabird](ERROR): Salinity reading out of range: 2.671589 psu 2019-07-25T00:16:33.979Z,1564013793.979 [CTD_Seabird](ERROR): Salinity reading out of range: 2.642855 psu 2019-07-25T00:16:34.980Z,1564013794.980 [CTD_Seabird](ERROR): Salinity reading out of range: 2.616366 psu 2019-07-25T00:16:35.994Z,1564013795.994 [CTD_Seabird](ERROR): Salinity reading out of range: 2.591483 psu 2019-07-25T00:16:36.988Z,1564013796.988 [CTD_Seabird](ERROR): Salinity reading out of range: 2.567431 psu 2019-07-25T00:16:37.992Z,1564013797.992 [CTD_Seabird](ERROR): Salinity reading out of range: 2.545661 psu 2019-07-25T00:16:38.997Z,1564013798.997 [CTD_Seabird](ERROR): Salinity reading out of range: 2.525443 psu 2019-07-25T00:16:39.000Z,1564013800.000 [CTD_Seabird](ERROR): Salinity reading out of range: 2.505175 psu 2019-07-25T00:16:40.008Z,1564013800.008 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 2.000000 meter 2019-07-25T00:16:40.009Z,1564013800.009 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread. 2019-07-25T00:16:40.293Z,1564013800.293 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-07-25T00:16:40.655Z,1564013800.655 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch -20.00 deg, mass-position 30.00 mm (1 active estimators). 2019-07-25T00:16:41.005Z,1564013801.005 [CTD_Seabird](ERROR): Salinity reading out of range: 2.486481 psu 2019-07-25T00:16:42.008Z,1564013802.008 [CTD_Seabird](ERROR): Salinity reading out of range: 2.468899 psu 2019-07-25T00:16:43.012Z,1564013803.012 [CTD_Seabird](ERROR): Salinity reading out of range: 2.451740 psu 2019-07-25T00:16:43.534Z,1564013803.534 [CommandLine](IMPORTANT): got command get depth 2019-07-25T00:16:43.535Z,1564013803.535 [CommandLine](IMPORTANT): depth 2.000000 m 2019-07-25T00:16:44.016Z,1564013804.016 [CTD_Seabird](ERROR): Salinity reading out of range: 2.435808 psu 2019-07-25T00:16:45.020Z,1564013805.020 [CTD_Seabird](ERROR): Salinity reading out of range: 2.419788 psu 2019-07-25T00:16:46.024Z,1564013806.024 [CTD_Seabird](ERROR): Salinity reading out of range: 2.402891 psu 2019-07-25T00:16:47.028Z,1564013807.028 [CTD_Seabird](ERROR): Salinity reading out of range: 2.385849 psu 2019-07-25T00:16:48.032Z,1564013808.032 [CTD_Seabird](ERROR): Salinity reading out of range: 2.369521 psu 2019-07-25T00:16:49.036Z,1564013809.036 [CTD_Seabird](ERROR): Salinity reading out of range: 2.353893 psu 2019-07-25T00:16:50.040Z,1564013810.040 [CTD_Seabird](ERROR): Salinity reading out of range: 2.339133 psu 2019-07-25T00:16:51.044Z,1564013811.044 [CTD_Seabird](ERROR): Salinity reading out of range: 2.324561 psu 2019-07-25T00:16:52.048Z,1564013812.048 [CTD_Seabird](ERROR): Salinity reading out of range: 2.311127 psu 2019-07-25T00:16:53.052Z,1564013813.052 [CTD_Seabird](ERROR): Salinity reading out of range: 2.298143 psu 2019-07-25T00:16:54.064Z,1564013814.064 [CTD_Seabird](ERROR): Salinity reading out of range: 2.286047 psu 2019-07-25T00:16:55.068Z,1564013815.068 [CTD_Seabird](ERROR): Salinity reading out of range: 2.274756 psu 2019-07-25T00:16:56.074Z,1564013816.074 [CTD_Seabird](ERROR): Salinity reading out of range: 2.263860 psu 2019-07-25T00:16:57.076Z,1564013817.076 [CTD_Seabird](ERROR): Salinity reading out of range: 2.253453 psu 2019-07-25T00:16:58.080Z,1564013818.080 [CTD_Seabird](ERROR): Salinity reading out of range: 2.243300 psu 2019-07-25T00:16:59.084Z,1564013819.084 [CTD_Seabird](ERROR): Salinity reading out of range: 2.234078 psu 2019-07-25T00:17:00.089Z,1564013820.089 [CTD_Seabird](ERROR): Salinity reading out of range: 2.323906 psu 2019-07-25T00:17:01.092Z,1564013821.092 [CTD_Seabird](ERROR): Salinity reading out of range: 2.292315 psu 2019-07-25T00:17:02.096Z,1564013822.096 [CTD_Seabird](ERROR): Salinity reading out of range: 2.122121 psu 2019-07-25T00:17:03.100Z,1564013823.100 [CTD_Seabird](ERROR): Salinity reading out of range: 2.030104 psu 2019-07-25T00:17:04.105Z,1564013824.105 [CTD_Seabird](ERROR): Salinity reading out of range: 1.969263 psu 2019-07-25T00:17:05.108Z,1564013825.108 [CTD_Seabird](ERROR): Salinity reading out of range: 1.935569 psu 2019-07-25T00:17:06.112Z,1564013826.112 [CTD_Seabird](ERROR): Salinity reading out of range: 2.045602 psu 2019-07-25T00:17:07.117Z,1564013827.117 [CTD_Seabird](ERROR): Salinity reading out of range: 2.857539 psu 2019-07-25T00:17:08.121Z,1564013828.121 [CTD_Seabird](ERROR): Salinity reading out of range: 3.613652 psu 2019-07-25T00:17:09.125Z,1564013829.125 [CTD_Seabird](ERROR): Salinity reading out of range: 3.542531 psu 2019-07-25T00:17:10.129Z,1564013830.129 [CTD_Seabird](ERROR): Salinity reading out of range: 3.348399 psu 2019-07-25T00:17:11.132Z,1564013831.132 [CTD_Seabird](ERROR): Salinity reading out of range: 3.235981 psu 2019-07-25T00:17:12.136Z,1564013832.136 [CTD_Seabird](ERROR): Salinity reading out of range: 3.135198 psu 2019-07-25T00:17:13.140Z,1564013833.140 [CTD_Seabird](ERROR): Salinity reading out of range: 3.104128 psu 2019-07-25T00:17:14.144Z,1564013834.144 [CTD_Seabird](ERROR): Salinity reading out of range: 3.091763 psu 2019-07-25T00:17:15.148Z,1564013835.148 [CTD_Seabird](ERROR): Salinity reading out of range: 3.081640 psu 2019-07-25T00:17:16.152Z,1564013836.152 [CTD_Seabird](ERROR): Salinity reading out of range: 3.097436 psu 2019-07-25T00:17:17.156Z,1564013837.156 [CTD_Seabird](ERROR): Salinity reading out of range: 3.109784 psu 2019-07-25T00:17:18.160Z,1564013838.160 [CTD_Seabird](ERROR): Salinity reading out of range: 3.151545 psu 2019-07-25T00:17:19.164Z,1564013839.164 [CTD_Seabird](ERROR): Salinity reading out of range: 3.193439 psu 2019-07-25T00:17:20.168Z,1564013840.168 [CTD_Seabird](ERROR): Salinity reading out of range: 3.240831 psu 2019-07-25T00:17:21.172Z,1564013841.172 [CTD_Seabird](ERROR): Salinity reading out of range: 3.275491 psu 2019-07-25T00:17:22.176Z,1564013842.176 [CTD_Seabird](ERROR): Salinity reading out of range: 3.949083 psu 2019-07-25T00:17:23.180Z,1564013843.180 [CTD_Seabird](ERROR): Salinity reading out of range: 2.304496 psu 2019-07-25T00:17:24.223Z,1564013844.223 [CTD_Seabird](ERROR): Salinity reading out of range: 2.457522 psu 2019-07-25T00:17:25.227Z,1564013845.227 [CTD_Seabird](ERROR): Salinity reading out of range: 1.926431 psu 2019-07-25T00:17:26.227Z,1564013846.227 [CTD_Seabird](ERROR): Salinity reading out of range: 1.724439 psu 2019-07-25T00:17:27.232Z,1564013847.232 [CTD_Seabird](ERROR): Salinity reading out of range: 1.570957 psu 2019-07-25T00:17:28.235Z,1564013848.235 [CTD_Seabird](ERROR): Salinity reading out of range: 1.410940 psu 2019-07-25T00:17:29.239Z,1564013849.239 [CTD_Seabird](ERROR): Salinity reading out of range: 1.425587 psu 2019-07-25T00:17:30.231Z,1564013850.231 [CTD_Seabird](ERROR): Salinity reading out of range: 1.216714 psu 2019-07-25T00:17:31.235Z,1564013851.235 [CTD_Seabird](ERROR): Salinity reading out of range: 1.086808 psu 2019-07-25T00:17:32.239Z,1564013852.239 [CTD_Seabird](ERROR): Salinity reading out of range: 0.996863 psu 2019-07-25T00:17:33.247Z,1564013853.247 [CTD_Seabird](ERROR): Salinity reading out of range: 0.934847 psu 2019-07-25T00:17:34.247Z,1564013854.247 [CTD_Seabird](ERROR): Salinity reading out of range: 0.887802 psu 2019-07-25T00:17:35.151Z,1564013855.151 [DVL_micro](ERROR): only read 45 of 46 data items 2019-07-25T00:17:35.151Z,1564013855.151 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 226 156 162 191 2 3 2 2 85.4 -46.7 198.1 2 -94.5 -23.3 198.1 2 85 -46 198 2 -94 -23 198 2 1. 222.5 -3.0 19.2 0.005 35.0 1489 100 2019-07-25T00:17:35.239Z,1564013855.239 [CTD_Seabird](ERROR): Salinity reading out of range: 0.855561 psu 2019-07-25T00:17:36.247Z,1564013856.247 [CTD_Seabird](ERROR): Salinity reading out of range: 0.843054 psu 2019-07-25T00:17:37.251Z,1564013857.251 [CTD_Seabird](ERROR): Salinity reading out of range: 0.841039 psu 2019-07-25T00:17:38.255Z,1564013858.255 [CTD_Seabird](ERROR): Salinity reading out of range: 0.853157 psu 2019-07-25T00:17:39.245Z,1564013859.245 [CTD_Seabird](ERROR): Salinity reading out of range: 0.878651 psu 2019-07-25T00:17:40.248Z,1564013860.248 [CTD_Seabird](ERROR): Salinity reading out of range: 0.908815 psu 2019-07-25T00:17:40.922Z,1564013860.922 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2019-07-25T00:17:41.082Z,1564013861.082 [Radio_Surface](INFO): Powering down 2019-07-25T00:17:41.252Z,1564013861.252 [CTD_Seabird](ERROR): Salinity reading out of range: 0.944112 psu 2019-07-25T00:17:42.256Z,1564013862.256 [CTD_Seabird](ERROR): Salinity reading out of range: 0.989259 psu 2019-07-25T00:17:43.260Z,1564013863.260 [CTD_Seabird](ERROR): Salinity reading out of range: 1.039950 psu 2019-07-25T00:17:44.264Z,1564013864.264 [CTD_Seabird](ERROR): Salinity reading out of range: 1.075529 psu 2019-07-25T00:17:45.268Z,1564013865.268 [CTD_Seabird](ERROR): Salinity reading out of range: 1.107414 psu 2019-07-25T00:17:46.274Z,1564013866.274 [CTD_Seabird](ERROR): Salinity reading out of range: 1.131732 psu 2019-07-25T00:17:47.280Z,1564013867.280 [CTD_Seabird](ERROR): Salinity reading out of range: 1.145311 psu 2019-07-25T00:17:48.281Z,1564013868.281 [CTD_Seabird](ERROR): Salinity reading out of range: 1.150112 psu 2019-07-25T00:17:48.687Z,1564013868.687 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 20.000000 meter 2019-07-25T00:17:49.285Z,1564013869.285 [CTD_Seabird](ERROR): Salinity reading out of range: 1.154005 psu 2019-07-25T00:17:50.290Z,1564013870.290 [CTD_Seabird](ERROR): Salinity reading out of range: 1.159457 psu 2019-07-25T00:17:51.293Z,1564013871.293 [CTD_Seabird](ERROR): Salinity reading out of range: 1.164472 psu 2019-07-25T00:17:52.296Z,1564013872.296 [CTD_Seabird](ERROR): Salinity reading out of range: 1.165289 psu 2019-07-25T00:17:53.300Z,1564013873.300 [CTD_Seabird](ERROR): Salinity reading out of range: 1.162154 psu 2019-07-25T00:17:54.304Z,1564013874.304 [CTD_Seabird](ERROR): Salinity reading out of range: 1.161139 psu 2019-07-25T00:17:55.308Z,1564013875.308 [CTD_Seabird](ERROR): Salinity reading out of range: 1.162068 psu 2019-07-25T00:17:56.312Z,1564013876.312 [CTD_Seabird](ERROR): Salinity reading out of range: 1.160781 psu 2019-07-25T00:17:57.316Z,1564013877.316 [CTD_Seabird](ERROR): Salinity reading out of range: 1.158420 psu 2019-07-25T00:17:57.780Z,1564013877.780 [DVL_micro](FAULT): DVL failed to acquire valid data within timeout. 2019-07-25T00:17:57.780Z,1564013877.780 [DVL_micro] Data Fault, FailCount= 1 2019-07-25T00:17:57.780Z,1564013877.780 [DVL_micro](ERROR): Data Fault 2019-07-25T00:17:57.923Z,1564013877.923 [CBIT](ERROR): Data Fault in component: DVL_micro 2019-07-25T00:17:58.246Z,1564013878.246 [DVL_micro](INFO): uninitialize:Powering down 2019-07-25T00:17:58.348Z,1564013878.348 [CTD_Seabird](ERROR): Salinity reading out of range: 1.156350 psu 2019-07-25T00:17:59.045Z,1564013879.045 [CBIT](INFO): Clearing failed state for component DVL_micro 2019-07-25T00:17:59.046Z,1564013879.046 [DVL_micro] No Fault, FailCount= 1 2019-07-25T00:17:59.352Z,1564013879.352 [CTD_Seabird](ERROR): Salinity reading out of range: 1.153993 psu 2019-07-25T00:17:59.411Z,1564013879.411 [DVL_micro](INFO): Initializing 2019-07-25T00:18:00.361Z,1564013880.361 [CTD_Seabird](ERROR): Salinity reading out of range: 1.152060 psu 2019-07-25T00:18:01.368Z,1564013881.368 [CTD_Seabird](ERROR): Salinity reading out of range: 1.149496 psu 2019-07-25T00:18:01.460Z,1564013881.460 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 25.000000 meter 2019-07-25T00:18:02.368Z,1564013882.368 [CTD_Seabird](ERROR): Salinity reading out of range: 1.147301 psu 2019-07-25T00:18:03.375Z,1564013883.375 [CTD_Seabird](ERROR): Salinity reading out of range: 1.144913 psu 2019-07-25T00:18:04.376Z,1564013884.376 [CTD_Seabird](ERROR): Salinity reading out of range: 1.141632 psu 2019-07-25T00:18:05.381Z,1564013885.381 [CTD_Seabird](ERROR): Salinity reading out of range: 1.137572 psu 2019-07-25T00:18:06.384Z,1564013886.384 [CTD_Seabird](ERROR): Salinity reading out of range: 1.133154 psu 2019-07-25T00:18:07.388Z,1564013887.388 [CTD_Seabird](ERROR): Salinity reading out of range: 1.128980 psu 2019-07-25T00:18:08.392Z,1564013888.392 [CTD_Seabird](ERROR): Salinity reading out of range: 1.125111 psu 2019-07-25T00:18:09.396Z,1564013889.396 [CTD_Seabird](ERROR): Salinity reading out of range: 1.121658 psu 2019-07-25T00:18:10.400Z,1564013890.400 [CTD_Seabird](ERROR): Salinity reading out of range: 1.119722 psu 2019-07-25T00:18:10.404Z,1564013890.404 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 30.000000 meter 2019-07-25T00:18:11.130Z,1564013891.130 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position 30.00 mm (2 active estimators). 2019-07-25T00:18:11.404Z,1564013891.404 [CTD_Seabird](ERROR): Salinity reading out of range: 1.117365 psu 2019-07-25T00:18:12.408Z,1564013892.408 [CTD_Seabird](ERROR): Salinity reading out of range: 1.114236 psu 2019-07-25T00:18:13.412Z,1564013893.412 [CTD_Seabird](ERROR): Salinity reading out of range: 1.111827 psu 2019-07-25T00:18:14.416Z,1564013894.416 [CTD_Seabird](ERROR): Salinity reading out of range: 1.110288 psu 2019-07-25T00:18:15.420Z,1564013895.420 [CTD_Seabird](ERROR): Salinity reading out of range: 1.109635 psu 2019-07-25T00:18:16.424Z,1564013896.424 [CTD_Seabird](ERROR): Salinity reading out of range: 1.114818 psu 2019-07-25T00:18:17.428Z,1564013897.428 [CTD_Seabird](ERROR): Salinity reading out of range: 1.122081 psu 2019-07-25T00:18:18.432Z,1564013898.432 [CTD_Seabird](ERROR): Salinity reading out of range: 1.124267 psu 2019-07-25T00:18:19.436Z,1564013899.436 [CTD_Seabird](ERROR): Salinity reading out of range: 1.122867 psu 2019-07-25T00:18:20.441Z,1564013900.441 [CTD_Seabird](ERROR): Salinity reading out of range: 1.120513 psu 2019-07-25T00:18:21.444Z,1564013901.444 [CTD_Seabird](ERROR): Salinity reading out of range: 1.118401 psu 2019-07-25T00:18:22.018Z,1564013902.018 [DVL_micro](ERROR): only read 44 of 46 data items 2019-07-25T00:18:22.019Z,1564013902.019 [DVL_micro](ERROR): Failed to parse:$#NQ.RES 0X0000 0 0 0 0 0 0 0 0 0 0 0 0 213 156 172 128 2 3 2 2 54.7 37.4 180.4 2 -15.2 -64.5 180.4 2 54 37 180 2 -15 -61.16 -1.77 222.4 -3.0 19.2 0.005 35.0 1489 97 2019-07-25T00:18:22.448Z,1564013902.448 [CTD_Seabird](ERROR): Salinity reading out of range: 1.116458 psu 2019-07-25T00:18:23.452Z,1564013903.452 [CTD_Seabird](ERROR): Salinity reading out of range: 1.115117 psu 2019-07-25T00:18:23.951Z,1564013903.951 [CommandLine](IMPORTANT): got command stop 2019-07-25T00:18:23.952Z,1564013903.952 [CommandLine](IMPORTANT): Scheduling is paused 2019-07-25T00:18:23.952Z,1564013903.952 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop 2019-07-25T00:18:24.088Z,1564013904.088 [MissionManager](INFO): MissionManager is completed. 2019-07-25T00:18:24.088Z,1564013904.088 [MissionManager](INFO): Uninitializing Mission profile_station 2019-07-25T00:18:24.088Z,1564013904.088 [profile_station] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station](DEBUG): Aggregate::uninitialize profile_station 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science](DEBUG): Aggregate::uninitialize profile_station:Science 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:A] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:C] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:D] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:G] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:PeakDetectChl] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectChl 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:StandardEnvelopes] Stopped 2019-07-25T00:18:24.089Z,1564013904.089 [profile_station:StandardEnvelopes](DEBUG): Aggregate::uninitialize profile_station:StandardEnvelopes 2019-07-25T00:18:24.090Z,1564013904.090 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:StandardEnvelopes:B.DepthEnvelope] Stopped 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:I.Pitch] Stopped 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:J.Buoyancy] Stopped 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:K.SetSpeed] Stopped 2019-07-25T00:18:24.094Z,1564013904.094 [profile_station:K.SetSpeed](DEBUG): Uninitialize. 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:L.DepthEnvelope] Stopped 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:L.DepthEnvelope](DEBUG): Uninitialize. 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:M.AltitudeEnvelope] Stopped 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:N.YoYo] Stopped 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:N.YoYo](DEBUG): Uninitialize YoYoComponent. 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:CircleWrapper] Stopped 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:CircleWrapper:A] Stopped 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:CircleWrapper:B.Circle] Stopped 2019-07-25T00:18:24.095Z,1564013904.095 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2019-07-25T00:18:24.459Z,1564013904.459 [MissionManager](IMPORTANT): Started mission Default 2019-07-25T00:18:24.459Z,1564013904.459 [Default] Running Loop=1 2019-07-25T00:18:24.459Z,1564013904.459 [Default](DEBUG): Aggregate::initialize Default 2019-07-25T00:18:24.459Z,1564013904.459 [Default:B.GoToSurface] Running Loop=1 2019-07-25T00:18:24.459Z,1564013904.459 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-25T00:18:24.459Z,1564013904.459 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-25T00:18:24.460Z,1564013904.460 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-25T00:18:24.460Z,1564013904.460 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-25T00:18:24.460Z,1564013904.460 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-25T00:18:24.461Z,1564013904.461 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-25T00:18:24.461Z,1564013904.461 [Default:A.Wait] Running Loop=1 2019-07-25T00:18:24.461Z,1564013904.461 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-07-25T00:18:24.462Z,1564013904.462 [WetLabsBB2FL](INFO): Powering down 2019-07-25T00:18:24.870Z,1564013904.870 [WetLabsBB2FL](FAULT): LCB fault: Software Overcurrent. 2019-07-25T00:18:24.870Z,1564013904.870 [WetLabsBB2FL] Hardware Fault, FailCount= 1 2019-07-25T00:18:24.870Z,1564013904.870 [WetLabsBB2FL](ERROR): Hardware Fault 2019-07-25T00:18:24.938Z,1564013904.938 [Aanderaa_O2](INFO): Powering down 2019-07-25T00:18:25.111Z,1564013905.111 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -13.00 mm (3 active estimators). 2019-07-25T00:18:25.118Z,1564013905.118 [Radio_Surface](INFO): Powering up 2019-07-25T00:18:25.241Z,1564013905.241 [CBIT](ERROR): Hardware Fault in component: WetLabsBB2FL 2019-07-25T00:18:25.385Z,1564013905.385 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 2019-07-25T00:18:25.386Z,1564013905.386 [WetLabsBB2FL] No Fault, FailCount= 1 2019-07-25T00:18:25.679Z,1564013905.679 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2 2019-07-25T00:18:25.679Z,1564013905.679 [WetLabsBB2FL](INFO): Powering up 2019-07-25T00:18:25.820Z,1564013905.820 [CommandLine](IMPORTANT): got command maintain clear 2019-07-25T00:18:25.889Z,1564013905.889 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-07-25T00:18:26.318Z,1564013906.318 [Reporter](INFO): SpeedControl.speedCmd 0.000000 m/s 2019-07-25T00:18:27.790Z,1564013907.790 [WetLabsBB2FL](INFO): Powering down 2019-07-25T00:18:30.626Z,1564013910.626 [DataOverHttps](INFO): Radio surface powered ON. 2019-07-25T00:18:36.403Z,1564013916.403 [CommandLine](IMPORTANT): got command get platform_mass_position centimeter 2019-07-25T00:18:36.403Z,1564013916.403 [CommandLine](IMPORTANT): platform_mass_position 2.999997 cm 2019-07-25T00:18:37.635Z,1564013917.635 [Default:A.Wait](INFO): Done Waiting. 2019-07-25T00:18:37.635Z,1564013917.635 [Default:A.Wait] Stopped 2019-07-25T00:18:37.635Z,1564013917.635 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-07-25T00:18:38.029Z,1564013918.029 [Default:CheckIn] Running Loop=1 2019-07-25T00:18:38.030Z,1564013918.030 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-07-25T00:18:38.030Z,1564013918.030 [Default:CheckIn:Read_GPS] Running Loop=1 2019-07-25T00:18:39.610Z,1564013919.610 [NAL9602](FAULT): GPS failed to acquire within timeout. 2019-07-25T00:18:39.610Z,1564013919.610 [NAL9602] Data Fault, FailCount= 2 2019-07-25T00:18:39.610Z,1564013919.610 [NAL9602](ERROR): Data Fault 2019-07-25T00:18:39.691Z,1564013919.691 [CBIT](ERROR): Data Fault in component: NAL9602 2019-07-25T00:18:40.021Z,1564013920.021 [NAL9602](INFO): Powering down 2019-07-25T00:18:40.938Z,1564013920.938 [CBIT](INFO): Clearing failed state for component NAL9602 2019-07-25T00:18:40.938Z,1564013920.938 [NAL9602] No Fault, FailCount= 2 2019-07-25T00:19:00.926Z,1564013940.926 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-07-25T00:19:10.324Z,1564013950.324 [NAL9602](INFO): Powering up NAL9602 2019-07-25T00:19:10.807Z,1564013950.807 [CommandLine](IMPORTANT): got command quit 2019-07-25T00:19:11.814Z,1564013951.814 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:11.814Z,1564013951.814 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:11.902Z,1564013951.902 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-07-25T00:19:11.902Z,1564013951.902 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:11.903Z,1564013951.903 [CommandLine](INFO): Join timeout helper Thread ID is 7690 2019-07-25T00:19:11.903Z,1564013951.903 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-07-25T00:19:11.903Z,1564013951.903 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:11.904Z,1564013951.904 [NavChartDb](INFO): Join timeout helper Thread ID is 7691 2019-07-25T00:19:12.078Z,1564013952.078 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:12.078Z,1564013952.078 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:12.094Z,1564013952.094 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-07-25T00:19:12.094Z,1564013952.094 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:12.094Z,1564013952.094 [Radio_Surface](INFO): Join timeout helper Thread ID is 7692 2019-07-25T00:19:12.410Z,1564013952.410 [Radio_Surface](INFO): Powering down 2019-07-25T00:19:12.411Z,1564013952.411 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:12.411Z,1564013952.411 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:12.411Z,1564013952.411 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-07-25T00:19:12.412Z,1564013952.412 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:12.412Z,1564013952.412 [DataOverHttps](INFO): Join timeout helper Thread ID is 7693 2019-07-25T00:19:12.642Z,1564013952.642 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:12.642Z,1564013952.642 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:12.662Z,1564013952.662 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-07-25T00:19:12.662Z,1564013952.662 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:12.662Z,1564013952.662 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7694 2019-07-25T00:19:13.090Z,1564013953.090 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:13.091Z,1564013953.091 [WetLabsBB2FL](INFO): Powering down 2019-07-25T00:19:13.091Z,1564013953.091 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:13.111Z,1564013953.111 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-07-25T00:19:13.111Z,1564013953.111 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:13.111Z,1564013953.111 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7695 2019-07-25T00:19:13.674Z,1564013953.674 [CTD_Seabird](INFO): Powering down 2019-07-25T00:19:13.686Z,1564013953.686 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:13.686Z,1564013953.686 [CTD_Seabird](INFO): Powering down 2019-07-25T00:19:13.698Z,1564013953.698 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:13.703Z,1564013953.703 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-07-25T00:19:13.703Z,1564013953.703 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:13.703Z,1564013953.703 [logger](INFO): Join timeout helper Thread ID is 7696 2019-07-25T00:19:13.750Z,1564013953.750 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:13.750Z,1564013953.750 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:13.763Z,1564013953.763 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-07-25T00:19:13.763Z,1564013953.763 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:13.763Z,1564013953.763 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-07-25T00:19:13.763Z,1564013953.763 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:13.763Z,1564013953.763 [controlThread](INFO): Join timeout helper Thread ID is 7697 2019-07-25T00:19:13.926Z,1564013953.926 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-25T00:19:13.926Z,1564013953.926 [controlThread](DEBUG): Uninitializing ControlThread 2019-07-25T00:19:13.927Z,1564013953.927 [Aanderaa_O2](INFO): Powering down 2019-07-25T00:19:13.948Z,1564013953.948 [AHRS_M2](INFO): Powering down 2019-07-25T00:19:14.090Z,1564013954.090 [DVL_micro](INFO): uninitialize:Powering down 2019-07-25T00:19:14.091Z,1564013954.091 [NAL9602](INFO): Powering down 2019-07-25T00:19:14.092Z,1564013954.092 [DAT](INFO): Powering down 2019-07-25T00:19:14.211Z,1564013954.211 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-07-25T00:19:14.212Z,1564013954.212 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-07-25T00:19:14.212Z,1564013954.212 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-07-25T00:19:14.212Z,1564013954.212 [MissionManager](INFO): Uninitializing Mission Default 2019-07-25T00:19:14.213Z,1564013954.213 [Default] Stopped 2019-07-25T00:19:14.213Z,1564013954.213 [Default](DEBUG): Aggregate::uninitialize Default 2019-07-25T00:19:14.213Z,1564013954.213 [Default:B.GoToSurface] Stopped 2019-07-25T00:19:14.213Z,1564013954.213 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-25T00:19:14.213Z,1564013954.213 [Default:CheckIn] Stopped 2019-07-25T00:19:14.213Z,1564013954.213 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-07-25T00:19:14.213Z,1564013954.213 [Default:CheckIn:Read_GPS] Stopped 2019-07-25T00:19:14.215Z,1564013954.215 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-07-25T00:19:14.216Z,1564013954.216 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-07-25T00:19:14.216Z,1564013954.216 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-07-25T00:19:14.216Z,1564013954.216 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-07-25T00:19:14.216Z,1564013954.216 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-07-25T00:19:14.217Z,1564013954.217 [BuoyancyServo](INFO): Powering down 2019-07-25T00:19:14.346Z,1564013954.346 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-07-25T00:19:14.346Z,1564013954.346 [ElevatorServo](INFO): Powering down 2019-07-25T00:19:14.347Z,1564013954.347 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-07-25T00:19:14.347Z,1564013954.347 [MassServo](INFO): Powering down 2019-07-25T00:19:14.348Z,1564013954.348 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-07-25T00:19:14.348Z,1564013954.348 [RudderServo](INFO): Powering down 2019-07-25T00:19:14.349Z,1564013954.349 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-07-25T00:19:14.349Z,1564013954.349 [ThrusterServo](INFO): Powering down 2019-07-25T00:19:14.350Z,1564013954.350 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-07-25T00:19:14.350Z,1564013954.350 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-07-25T00:19:14.350Z,1564013954.350 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-07-25T00:19:14.350Z,1564013954.350 [CBIT](DEBUG): Powering off loads. 2019-07-25T00:19:14.362Z,1564013954.362 [CBIT](DEBUG): Disabling WDT. 2019-07-25T00:19:14.374Z,1564013954.374 [CBIT](DEBUG): Opening all GF detection circuits. 2019-07-25T00:19:14.375Z,1564013954.375 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:14.410Z,1564013954.410 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:14.415Z,1564013954.415 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:14.477Z,1564013954.477 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:14.484Z,1564013954.484 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:14.533Z,1564013954.533 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-25T00:19:14.599Z,1564013954.599 [logger ThreadHandler](INFO): Thread cancelled.