2017-10-06T22:59:08.501Z,1507330748.501 [Supervisor](DEBUG): Initializing supervisor.
2017-10-06T22:59:08.504Z,1507330748.504 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2017-10-06T22:59:08.505Z,1507330748.505 [SyncHandler](INFO): Protected caller Thread ID is 3169
2017-10-06T22:59:08.505Z,1507330748.505 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2017-10-06T22:59:08.506Z,1507330748.506 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2017-10-06T22:59:08.507Z,1507330748.507 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3170
2017-10-06T22:59:08.510Z,1507330748.510 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2017-10-06T22:59:08.523Z,1507330748.523 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2017-10-06T22:59:08.525Z,1507330748.525 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2017-10-06T22:59:08.525Z,1507330748.525 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3171
2017-10-06T22:59:08.526Z,1507330748.526 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2017-10-06T22:59:08.527Z,1507330748.527 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2017-10-06T22:59:08.527Z,1507330748.527 [logger ThreadHandler](INFO): Protected caller Thread ID is 3172
2017-10-06T22:59:08.530Z,1507330748.530 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2017-10-06T22:59:08.530Z,1507330748.530 [Supervisor](INFO): Looking for Config files in directory: Config/
2017-10-06T22:59:08.533Z,1507330748.533 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2017-10-06T22:59:08.717Z,1507330748.717 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2017-10-06T22:59:08.717Z,1507330748.717 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2017-10-06T22:59:08.840Z,1507330748.840 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2017-10-06T22:59:08.840Z,1507330748.840 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2017-10-06T22:59:09.065Z,1507330749.065 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2017-10-06T22:59:09.066Z,1507330749.066 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2017-10-06T22:59:09.462Z,1507330749.462 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2017-10-06T22:59:09.462Z,1507330749.462 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2017-10-06T22:59:09.872Z,1507330749.872 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2017-10-06T22:59:09.872Z,1507330749.872 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2017-10-06T22:59:10.459Z,1507330750.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2017-10-06T22:59:10.460Z,1507330750.460 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2017-10-06T22:59:10.960Z,1507330750.960 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2017-10-06T22:59:10.961Z,1507330750.961 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2017-10-06T22:59:11.523Z,1507330751.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2017-10-06T22:59:11.524Z,1507330751.524 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2017-10-06T22:59:11.624Z,1507330751.624 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2017-10-06T22:59:12.000Z,1507330752.000 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2017-10-06T22:59:12.001Z,1507330752.001 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2017-10-06T22:59:12.163Z,1507330752.163 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2017-10-06T22:59:12.164Z,1507330752.164 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2017-10-06T22:59:12.423Z,1507330752.423 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2017-10-06T22:59:12.424Z,1507330752.424 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2017-10-06T22:59:12.748Z,1507330752.748 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2017-10-06T22:59:12.748Z,1507330752.748 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2017-10-06T22:59:12.876Z,1507330752.876 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2017-10-06T22:59:12.877Z,1507330752.877 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2017-10-06T22:59:13.055Z,1507330753.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2017-10-06T22:59:13.057Z,1507330753.057 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2017-10-06T22:59:13.059Z,1507330753.059 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2017-10-06T22:59:13.374Z,1507330753.374 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2017-10-06T22:59:13.375Z,1507330753.375 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2017-10-06T22:59:13.471Z,1507330753.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2017-10-06T22:59:13.723Z,1507330753.723 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2017-10-06T22:59:13.919Z,1507330753.919 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2017-10-06T22:59:14.094Z,1507330754.094 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2017-10-06T22:59:14.273Z,1507330754.273 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2017-10-06T22:59:14.477Z,1507330754.477 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2017-10-06T22:59:14.595Z,1507330754.595 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2017-10-06T22:59:14.775Z,1507330754.775 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2017-10-06T22:59:14.962Z,1507330754.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2017-10-06T22:59:15.193Z,1507330755.193 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2017-10-06T22:59:15.193Z,1507330755.193 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2017-10-06T22:59:15.199Z,1507330755.199 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2017-10-06T22:59:15.336Z,1507330755.336 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2017-10-06T22:59:15.337Z,1507330755.337 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2017-10-06T22:59:15.362Z,1507330755.362 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2017-10-06T22:59:15.362Z,1507330755.362 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2017-10-06T22:59:15.401Z,1507330755.401 [DepthRateCalculator] Loaded
2017-10-06T22:59:15.401Z,1507330755.401 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2017-10-06T22:59:15.408Z,1507330755.408 [PitchRateCalculator] Loaded
2017-10-06T22:59:15.409Z,1507330755.409 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2017-10-06T22:59:15.427Z,1507330755.427 [SpeedCalculator] Loaded
2017-10-06T22:59:15.428Z,1507330755.428 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2017-10-06T22:59:15.453Z,1507330755.453 [TempGradientCalculator] Loaded
2017-10-06T22:59:15.453Z,1507330755.453 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2017-10-06T22:59:15.471Z,1507330755.471 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2017-10-06T22:59:15.471Z,1507330755.471 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2017-10-06T22:59:15.478Z,1507330755.478 [YawRateCalculator] Loaded
2017-10-06T22:59:15.478Z,1507330755.478 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2017-10-06T22:59:15.479Z,1507330755.479 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2017-10-06T22:59:15.479Z,1507330755.479 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2017-10-06T22:59:15.516Z,1507330755.516 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2017-10-06T22:59:15.516Z,1507330755.516 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2017-10-06T22:59:15.888Z,1507330755.888 [DataOverHttps] Loaded
2017-10-06T22:59:15.888Z,1507330755.888 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2017-10-06T22:59:15.916Z,1507330755.916 [Depth_Keller] Loaded
2017-10-06T22:59:15.917Z,1507330755.917 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2017-10-06T22:59:15.922Z,1507330755.922 [DropWeight] Loaded
2017-10-06T22:59:15.923Z,1507330755.923 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2017-10-06T22:59:15.942Z,1507330755.942 [Onboard] Loaded
2017-10-06T22:59:15.942Z,1507330755.942 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2017-10-06T22:59:15.954Z,1507330755.954 [Radio_Surface] Loaded
2017-10-06T22:59:15.955Z,1507330755.955 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2017-10-06T22:59:15.956Z,1507330755.956 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0
2017-10-06T22:59:15.956Z,1507330755.956 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3252
2017-10-06T22:59:16.014Z,1507330756.014 [PNI_TCM] Loaded
2017-10-06T22:59:16.015Z,1507330756.015 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2017-10-06T22:59:16.088Z,1507330756.088 [Rowe_600LCM] Loaded
2017-10-06T22:59:16.089Z,1507330756.089 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2017-10-06T22:59:16.090Z,1507330756.090 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409054E0
2017-10-06T22:59:16.090Z,1507330756.090 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 3253
2017-10-06T22:59:18.347Z,1507330758.347 [BPC1] Loaded
2017-10-06T22:59:18.347Z,1507330758.347 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2017-10-06T22:59:18.348Z,1507330758.348 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2017-10-06T22:59:18.348Z,1507330758.348 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2017-10-06T22:59:18.501Z,1507330758.501 [SBIT](DEBUG): Construct Startup Built In Test.
2017-10-06T22:59:18.533Z,1507330758.533 [SBIT] Loaded
2017-10-06T22:59:18.534Z,1507330758.534 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2017-10-06T22:59:18.535Z,1507330758.535 [IBIT](DEBUG): Construct Initiated Built In Test.
2017-10-06T22:59:18.560Z,1507330758.560 [IBIT] Loaded
2017-10-06T22:59:18.560Z,1507330758.560 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2017-10-06T22:59:18.564Z,1507330758.564 [CBIT](DEBUG): Construct Continuous Built In Test.
2017-10-06T22:59:18.757Z,1507330758.757 [CBIT] Loaded
2017-10-06T22:59:18.757Z,1507330758.757 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2017-10-06T22:59:18.758Z,1507330758.758 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2017-10-06T22:59:18.758Z,1507330758.758 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2017-10-06T22:59:18.947Z,1507330758.947 [Aanderaa_O2] Loaded
2017-10-06T22:59:18.947Z,1507330758.947 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2017-10-06T22:59:19.048Z,1507330759.048 [CTD_NeilBrown] Loaded
2017-10-06T22:59:19.048Z,1507330759.048 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2017-10-06T22:59:19.049Z,1507330759.049 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 409F84E0
2017-10-06T22:59:19.050Z,1507330759.050 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 3254
2017-10-06T22:59:19.071Z,1507330759.071 [ESPComponent] Loaded
2017-10-06T22:59:19.071Z,1507330759.071 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2017-10-06T22:59:19.089Z,1507330759.089 [PAR_Licor] Loaded
2017-10-06T22:59:19.089Z,1507330759.089 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2017-10-06T22:59:19.147Z,1507330759.147 [WetLabsBB2FL] Loaded
2017-10-06T22:59:19.147Z,1507330759.147 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2017-10-06T22:59:19.148Z,1507330759.148 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A284E0
2017-10-06T22:59:19.149Z,1507330759.149 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3255
2017-10-06T22:59:19.149Z,1507330759.149 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2017-10-06T22:59:19.150Z,1507330759.150 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2017-10-06T22:59:19.417Z,1507330759.417 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2017-10-06T22:59:19.418Z,1507330759.418 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2017-10-06T22:59:19.508Z,1507330759.508 [VerticalControl](DEBUG): Construct VerticalControl.
2017-10-06T22:59:19.629Z,1507330759.629 [VerticalControl] Loaded
2017-10-06T22:59:19.630Z,1507330759.630 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2017-10-06T22:59:19.631Z,1507330759.631 [HorizontalControl](DEBUG): Construct HorizontalControl.
2017-10-06T22:59:19.705Z,1507330759.705 [HorizontalControl] Loaded
2017-10-06T22:59:19.705Z,1507330759.705 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2017-10-06T22:59:19.706Z,1507330759.706 [SpeedControl](DEBUG): Construct SpeedControl.
2017-10-06T22:59:19.713Z,1507330759.713 [SpeedControl] Loaded
2017-10-06T22:59:19.713Z,1507330759.713 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2017-10-06T22:59:19.714Z,1507330759.714 [LoopControl](DEBUG): Construct LoopControl.
2017-10-06T22:59:19.715Z,1507330759.715 [LoopControl] Loaded
2017-10-06T22:59:19.715Z,1507330759.715 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2017-10-06T22:59:19.716Z,1507330759.716 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2017-10-06T22:59:19.716Z,1507330759.716 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2017-10-06T22:59:19.843Z,1507330759.843 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2017-10-06T22:59:19.843Z,1507330759.843 [StratificationFrontDetector](DEBUG): (re)initializing
2017-10-06T22:59:19.844Z,1507330759.844 [StratificationFrontDetector] Loaded
2017-10-06T22:59:19.844Z,1507330759.844 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2017-10-06T22:59:19.845Z,1507330759.845 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2017-10-06T22:59:19.845Z,1507330759.845 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2017-10-06T22:59:19.970Z,1507330759.970 [BuoyancyServo] Loaded
2017-10-06T22:59:19.970Z,1507330759.970 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2017-10-06T22:59:19.985Z,1507330759.985 [ElevatorServo] Loaded
2017-10-06T22:59:19.985Z,1507330759.985 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2017-10-06T22:59:19.000Z,1507330760.000 [MassServo] Loaded
2017-10-06T22:59:19.000Z,1507330760.000 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2017-10-06T22:59:20.014Z,1507330760.014 [RudderServo] Loaded
2017-10-06T22:59:20.014Z,1507330760.014 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2017-10-06T22:59:20.029Z,1507330760.029 [ThrusterServo] Loaded
2017-10-06T22:59:20.029Z,1507330760.029 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2017-10-06T22:59:20.030Z,1507330760.030 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2017-10-06T22:59:20.030Z,1507330760.030 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2017-10-06T22:59:20.159Z,1507330760.159 [DeadReckonUsingMultipleVelocitySources] Loaded
2017-10-06T22:59:20.159Z,1507330760.159 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2017-10-06T22:59:20.228Z,1507330760.228 [DeadReckonUsingSpeedCalculator] Loaded
2017-10-06T22:59:20.229Z,1507330760.229 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2017-10-06T22:59:20.249Z,1507330760.249 [NavChart] Loaded
2017-10-06T22:59:20.249Z,1507330760.249 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2017-10-06T22:59:20.255Z,1507330760.255 [UniversalFixResidualReporter] Loaded
2017-10-06T22:59:20.255Z,1507330760.255 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2017-10-06T22:59:20.255Z,1507330760.255 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2017-10-06T22:59:20.264Z,1507330760.264 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2017-10-06T22:59:20.265Z,1507330760.265 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2017-10-06T22:59:20.275Z,1507330760.275 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2017-10-06T22:59:20.276Z,1507330760.276 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BCF4E0
2017-10-06T22:59:20.277Z,1507330760.277 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3256
2017-10-06T22:59:20.289Z,1507330760.289 [Supervisor](INFO): Main Thread ID is 3168
2017-10-06T22:59:20.289Z,1507330760.289 [Supervisor](DEBUG): Running supervisor.
2017-10-06T22:59:20.290Z,1507330760.290 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3257
2017-10-06T22:59:20.293Z,1507330760.293 [controlThread ThreadHandler](INFO): Handler Thread ID is 3258
2017-10-06T22:59:20.293Z,1507330760.293 [controlThread](DEBUG): Initializing ControlThread
2017-10-06T22:59:20.294Z,1507330760.294 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2017-10-06T22:59:20.294Z,1507330760.294 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2017-10-06T22:59:20.295Z,1507330760.295 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2017-10-06T22:59:20.295Z,1507330760.295 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2017-10-06T22:59:20.296Z,1507330760.296 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2017-10-06T22:59:20.297Z,1507330760.297 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2017-10-06T22:59:20.302Z,1507330760.302 [SBIT](INFO): Initialize SBIT Component.
2017-10-06T22:59:20.302Z,1507330760.302 [SBIT](IMPORTANT): git: 2017-09-28
2017-10-06T22:59:20.302Z,1507330760.302 [SBIT](INFO): git hash: 24ca05b165c0d131bc4566abd5c70f54463494da
2017-10-06T22:59:20.303Z,1507330760.303 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2017-10-06T22:59:20.304Z,1507330760.304 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #2 PREEMPT Tue Oct 3 09:53:58 PDT 2017
2017-10-06T22:59:20.305Z,1507330760.305 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2017-10-06T22:59:20.306Z,1507330760.306 [IBIT](INFO): Initialize IBIT Component.
2017-10-06T22:59:20.307Z,1507330760.307 [CBIT](DEBUG): Initialize CBIT Component.
2017-10-06T22:59:20.307Z,1507330760.307 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2017-10-06T22:59:20.308Z,1507330760.308 [logger ThreadHandler](INFO): Handler Thread ID is 3259
2017-10-06T22:59:20.311Z,1507330760.311 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3260
2017-10-06T22:59:20.335Z,1507330760.335 [Radio_Surface](INFO): Powering up
2017-10-06T22:59:20.336Z,1507330760.336 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 3261
2017-10-06T22:59:20.336Z,1507330760.336 [Rowe_600LCM](INFO): Initializing
2017-10-06T22:59:20.337Z,1507330760.337 [Rowe_600LCM](INFO): Checking LCM
2017-10-06T22:59:20.345Z,1507330760.345 [Rowe_600LCM](INFO): LCM OK
2017-10-06T22:59:20.345Z,1507330760.345 [Rowe_600LCM](INFO): Powering up
2017-10-06T22:59:20.351Z,1507330760.351 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 3262
2017-10-06T22:59:20.352Z,1507330760.352 [CTD_NeilBrown](INFO): Powering down
2017-10-06T22:59:20.383Z,1507330760.383 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3263
2017-10-06T22:59:20.384Z,1507330760.384 [WetLabsBB2FL](INFO): Powering down
2017-10-06T22:59:20.399Z,1507330760.399 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2017-10-06T22:59:20.401Z,1507330760.401 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2017-10-06T22:59:20.402Z,1507330760.402 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2017-10-06T22:59:20.402Z,1507330760.402 [LoopControl](DEBUG): Initialize LoopControlComponent.
2017-10-06T22:59:20.405Z,1507330760.405 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-06T22:59:20.405Z,1507330760.405 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T22:59:20.406Z,1507330760.406 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T22:59:20.411Z,1507330760.411 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-06T22:59:20.411Z,1507330760.411 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T22:59:20.412Z,1507330760.412 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T22:59:20.412Z,1507330760.412 [NavChart](DEBUG): Initialize NavChart Navigation.
2017-10-06T22:59:20.413Z,1507330760.413 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2017-10-06T22:59:20.414Z,1507330760.414 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2017-10-06T22:59:20.432Z,1507330760.432 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3264
2017-10-06T22:59:20.437Z,1507330760.437 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory
2017-10-06T22:59:20.473Z,1507330760.473 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-06T22:59:20.513Z,1507330760.513 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2017-10-06T22:59:20.514Z,1507330760.514 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2017-10-06T22:59:20.575Z,1507330760.575 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2017-10-06T22:59:20.577Z,1507330760.577 [Default:A.Wait](DEBUG): Construct Wait.
2017-10-06T22:59:20.591Z,1507330760.591 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2017-10-06T22:59:20.624Z,1507330760.624 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2017-10-06T22:59:20.655Z,1507330760.655 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2017-10-06T22:59:20.662Z,1507330760.662 [Default:E.Execute](DEBUG): Construct Execute.
2017-10-06T22:59:20.696Z,1507330760.696 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
xmlns:Guidance="Tethys/Guidance"
xmlns:Units="Tethys/Units"
xmlns:Universal="Tethys/Universal"
xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Sequence/>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Sequence/>
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Sequence/>
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn 300</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2017-10-06T22:59:20.705Z,1507330760.705 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,Onboard,PNI_TCM,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2017-10-06T22:59:20.728Z,1507330760.728 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2017-10-06T22:59:20.740Z,1507330760.740 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2017-10-06T22:59:20.776Z,1507330760.776 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000
2017-10-06T22:59:20.777Z,1507330760.777 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2017-10-06T22:59:20.809Z,1507330760.809 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000
2017-10-06T22:59:20.811Z,1507330760.811 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2017-10-06T22:59:20.844Z,1507330760.844 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000
2017-10-06T22:59:20.845Z,1507330760.845 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2017-10-06T22:59:20.879Z,1507330760.879 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4CA60M.000
2017-10-06T22:59:20.880Z,1507330760.880 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2017-10-06T22:59:20.903Z,1507330760.903 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000
2017-10-06T22:59:20.903Z,1507330760.903 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2017-10-06T22:59:20.926Z,1507330760.926 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA61M.000
2017-10-06T22:59:20.926Z,1507330760.926 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2017-10-06T22:59:20.948Z,1507330760.948 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA62M.000
2017-10-06T22:59:20.948Z,1507330760.948 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T22:59:20.967Z,1507330760.967 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA83M.000
2017-10-06T22:59:21.017Z,1507330761.017 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T22:59:21.087Z,1507330761.087 [ESPComponent](INFO): powering down ESP
2017-10-06T22:59:21.709Z,1507330761.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:21.739Z,1507330761.739 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:21.881Z,1507330761.881 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:21.887Z,1507330761.887 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2017-10-06T22:59:21.898Z,1507330761.898 [ElevatorServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:21.907Z,1507330761.907 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2017-10-06T22:59:21.913Z,1507330761.913 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:21.931Z,1507330761.931 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:59:21.965Z,1507330761.965 [RudderServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:21.969Z,1507330761.969 [RudderServo](DEBUG): Initializing RudderServo.
2017-10-06T22:59:21.988Z,1507330761.988 [ThrusterServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:21.995Z,1507330761.995 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2017-10-06T22:59:22.236Z,1507330762.236 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2017-10-06T22:59:22.236Z,1507330762.236 [DropWeight] Hardware Fault, FailCount= 1
2017-10-06T22:59:22.236Z,1507330762.236 [DropWeight](ERROR): Hardware Fault
2017-10-06T22:59:22.313Z,1507330762.313 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:22.314Z,1507330762.314 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:22.380Z,1507330762.380 [CommandLine](FAULT): Scheduling is paused
2017-10-06T22:59:22.381Z,1507330762.381 [CBIT](INFO): Critical error at 20171006T225922
2017-10-06T22:59:22.381Z,1507330762.381 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2017-10-06T22:59:22.384Z,1507330762.384 [CBIT](ERROR): Hardware Fault in component: DropWeight
2017-10-06T22:59:22.385Z,1507330762.385 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2017-10-06T22:59:24.638Z,1507330764.638 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-06T22:59:24.765Z,1507330764.765 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 38400 >& /dev/null &
2017-10-06T22:59:24.880Z,1507330764.880 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-06T22:59:24.882Z,1507330764.882 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-06T22:59:24.907Z,1507330764.907 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-06T22:59:31.538Z,1507330771.538 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T22:59:31.538Z,1507330771.538 [Aanderaa_O2] Data Fault, FailCount= 1
2017-10-06T22:59:31.538Z,1507330771.538 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T22:59:31.562Z,1507330771.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:31.564Z,1507330771.564 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:31.845Z,1507330771.845 [CBIT](INFO): Critical error at 20171006T225922
2017-10-06T22:59:31.848Z,1507330771.848 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T22:59:31.892Z,1507330771.892 [Aanderaa_O2](INFO): Powering down
2017-10-06T22:59:32.000Z,1507330772.000 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:32.002Z,1507330772.002 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:32.373Z,1507330772.373 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:32.385Z,1507330772.385 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:32.663Z,1507330772.663 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003392
2017-10-06T22:59:32.695Z,1507330772.695 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:32.696Z,1507330772.696 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:32.738Z,1507330772.738 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T22:59:32.738Z,1507330772.738 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-06T22:59:33.103Z,1507330773.103 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:33.104Z,1507330773.104 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:33.517Z,1507330773.517 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:33.530Z,1507330773.530 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2017-10-06T22:59:34.730Z,1507330774.730 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T22:59:34.731Z,1507330774.731 [Aanderaa_O2] Data Fault, FailCount= 2
2017-10-06T22:59:34.731Z,1507330774.731 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T22:59:34.859Z,1507330774.859 [MassServo](FAULT): Overload Error
2017-10-06T22:59:34.859Z,1507330774.859 [MassServo] Hardware Fault, FailCount= 1
2017-10-06T22:59:34.859Z,1507330774.859 [MassServo](ERROR): Hardware Fault
2017-10-06T22:59:34.984Z,1507330774.984 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T22:59:34.984Z,1507330774.984 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T22:59:35.094Z,1507330775.094 [Aanderaa_O2](INFO): Powering down
2017-10-06T22:59:35.180Z,1507330775.180 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:59:35.180Z,1507330775.180 [MassServo](INFO): Powering down
2017-10-06T22:59:35.965Z,1507330775.965 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:35.966Z,1507330775.966 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:59:35.976Z,1507330775.976 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T22:59:35.976Z,1507330775.976 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-06T22:59:35.976Z,1507330775.976 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:59:35.976Z,1507330775.976 [MassServo] No Fault, FailCount= 1
2017-10-06T22:59:36.290Z,1507330776.290 [BPC1](FAULT): Failed to initialize
2017-10-06T22:59:36.290Z,1507330776.290 [BPC1] Communications Fault, FailCount= 1
2017-10-06T22:59:36.290Z,1507330776.290 [BPC1](ERROR): Communications Fault
2017-10-06T22:59:36.355Z,1507330776.355 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T22:59:37.221Z,1507330777.221 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T22:59:37.571Z,1507330777.571 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T22:59:37.571Z,1507330777.571 [BPC1] No Fault, FailCount= 1
2017-10-06T22:59:37.963Z,1507330777.963 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T22:59:37.963Z,1507330777.963 [Aanderaa_O2] Data Fault, FailCount= 3
2017-10-06T22:59:37.963Z,1507330777.963 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T22:59:38.005Z,1507330778.005 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T22:59:38.006Z,1507330778.006 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2017-10-06T22:59:38.291Z,1507330778.291 [Aanderaa_O2](INFO): Powering down
2017-10-06T22:59:39.983Z,1507330779.983 [MassServo](FAULT): Overload Error
2017-10-06T22:59:39.983Z,1507330779.983 [MassServo] Hardware Fault, FailCount= 2
2017-10-06T22:59:39.983Z,1507330779.983 [MassServo](ERROR): Hardware Fault
2017-10-06T22:59:39.988Z,1507330779.988 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T22:59:40.359Z,1507330780.359 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:59:40.359Z,1507330780.359 [MassServo](INFO): Powering down
2017-10-06T22:59:41.151Z,1507330781.151 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:41.152Z,1507330781.152 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:59:41.171Z,1507330781.171 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:59:41.171Z,1507330781.171 [MassServo] No Fault, FailCount= 2
2017-10-06T22:59:45.231Z,1507330785.231 [MassServo](FAULT): Overload Error
2017-10-06T22:59:45.231Z,1507330785.231 [MassServo] Hardware Fault, FailCount= 3
2017-10-06T22:59:45.231Z,1507330785.231 [MassServo](ERROR): Hardware Fault
2017-10-06T22:59:45.237Z,1507330785.237 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T22:59:45.596Z,1507330785.596 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:59:45.596Z,1507330785.596 [MassServo](INFO): Powering down
2017-10-06T22:59:46.354Z,1507330786.354 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:46.355Z,1507330786.355 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:59:46.368Z,1507330786.368 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:59:46.368Z,1507330786.368 [MassServo] No Fault, FailCount= 3
2017-10-06T22:59:50.435Z,1507330790.435 [MassServo](FAULT): Overload Error
2017-10-06T22:59:50.435Z,1507330790.435 [MassServo] Hardware Fault, FailCount= 4
2017-10-06T22:59:50.435Z,1507330790.435 [MassServo](ERROR): Hardware Fault
2017-10-06T22:59:50.441Z,1507330790.441 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T22:59:50.767Z,1507330790.767 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:59:50.767Z,1507330790.767 [MassServo](INFO): Powering down
2017-10-06T22:59:51.580Z,1507330791.580 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:51.700Z,1507330791.700 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T22:59:51.716Z,1507330791.716 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T22:59:51.716Z,1507330791.716 [MassServo] No Fault, FailCount= 4
2017-10-06T22:59:53.104Z,1507330793.104 [BPC1](FAULT): Failed to initialize
2017-10-06T22:59:53.104Z,1507330793.104 [BPC1] Communications Fault, FailCount= 2
2017-10-06T22:59:53.104Z,1507330793.104 [BPC1](ERROR): Communications Fault
2017-10-06T22:59:53.182Z,1507330793.182 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T22:59:54.391Z,1507330794.391 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T22:59:54.391Z,1507330794.391 [BPC1] No Fault, FailCount= 2
2017-10-06T22:59:55.210Z,1507330795.210 [MassServo](FAULT): Overload Error
2017-10-06T22:59:55.211Z,1507330795.211 [MassServo] Hardware Fault, FailCount= 5
2017-10-06T22:59:55.211Z,1507330795.211 [MassServo](ERROR): Hardware Fault
2017-10-06T22:59:55.216Z,1507330795.216 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T22:59:55.216Z,1507330795.216 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2017-10-06T22:59:55.583Z,1507330795.583 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T22:59:55.583Z,1507330795.583 [MassServo](INFO): Powering down
2017-10-06T22:59:55.606Z,1507330795.606 [CBIT](INFO): Critical error at 20171006T225955
2017-10-06T22:59:56.370Z,1507330796.370 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T22:59:56.489Z,1507330796.489 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:00:09.901Z,1507330809.901 [BPC1](FAULT): Failed to initialize
2017-10-06T23:00:09.901Z,1507330809.901 [BPC1] Communications Fault, FailCount= 3
2017-10-06T23:00:09.901Z,1507330809.901 [BPC1](ERROR): Communications Fault
2017-10-06T23:00:10.013Z,1507330810.013 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:00:11.194Z,1507330811.194 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:00:11.195Z,1507330811.195 [BPC1] No Fault, FailCount= 3
2017-10-06T23:00:11.903Z,1507330811.903 [CommandLine](IMPORTANT): got command show stack
2017-10-06T23:00:11.903Z,1507330811.903 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-06T23:00:11.903Z,1507330811.903 [MissionManager](IMPORTANT): Mission loaded, but not running.
2017-10-06T23:00:28.118Z,1507330828.118 [BPC1](FAULT): Failed to initialize
2017-10-06T23:00:28.118Z,1507330828.118 [BPC1] Communications Fault, FailCount= 4
2017-10-06T23:00:28.118Z,1507330828.118 [BPC1](ERROR): Communications Fault
2017-10-06T23:00:28.229Z,1507330828.229 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:00:28.414Z,1507330828.414 [SBIT](IMPORTANT): Beginning Startup BIT
2017-10-06T23:00:28.442Z,1507330828.442 [CBIT](IMPORTANT): Beginning ground fault scan
2017-10-06T23:00:29.228Z,1507330829.228 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:00:29.229Z,1507330829.229 [BPC1] No Fault, FailCount= 4
2017-10-06T23:00:38.777Z,1507330838.777 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.007185
CHAN A1 (24V): 0.004032
CHAN A2 (12V): -0.005413
CHAN A3 (5V): -0.002555
CHAN B0 (3.3V): -0.000987
CHAN B1 (3.15aV): -0.001322
CHAN B2 (3.15bV): -0.000638
CHAN B3 (GND): -0.000622
OPEN: 0.004576
Full Scale Calc: 4.765 mA, -1.589 mA
2017-10-06T23:00:41.568Z,1507330841.568 [SBIT](ERROR): Could not read massPosReader_.
2017-10-06T23:00:44.699Z,1507330844.699 [BPC1](FAULT): Failed to initialize
2017-10-06T23:00:44.699Z,1507330844.699 [BPC1] Communications Fault, FailCount= 5
2017-10-06T23:00:44.699Z,1507330844.699 [BPC1](ERROR): Communications Fault
2017-10-06T23:00:44.848Z,1507330844.848 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:00:46.039Z,1507330846.039 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:00:46.039Z,1507330846.039 [BPC1] No Fault, FailCount= 5
2017-10-06T23:01:01.476Z,1507330861.476 [BPC1](FAULT): Failed to initialize
2017-10-06T23:01:01.476Z,1507330861.476 [BPC1] Communications Fault, FailCount= 6
2017-10-06T23:01:01.476Z,1507330861.476 [BPC1](ERROR): Communications Fault
2017-10-06T23:01:01.559Z,1507330861.559 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:01:02.781Z,1507330862.781 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:01:02.781Z,1507330862.781 [BPC1] No Fault, FailCount= 6
2017-10-06T23:01:08.358Z,1507330868.358 [SBIT](ERROR): Could not read massPosReader_.
2017-10-06T23:01:08.358Z,1507330868.358 [SBIT](FAULT): Control surface position failure.
2017-10-06T23:01:16.235Z,1507330876.235 [NavChartDb](INFO): # of records loaded: 5000
2017-10-06T23:01:18.280Z,1507330878.280 [BPC1](FAULT): Failed to initialize
2017-10-06T23:01:18.280Z,1507330878.280 [BPC1] Communications Fault, FailCount= 7
2017-10-06T23:01:18.280Z,1507330878.280 [BPC1](ERROR): Communications Fault
2017-10-06T23:01:18.384Z,1507330878.384 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:01:19.579Z,1507330879.579 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:01:19.579Z,1507330879.579 [BPC1] No Fault, FailCount= 7
2017-10-06T23:01:20.362Z,1507330880.362 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2017-10-06T23:01:20.362Z,1507330880.362 [Rowe_600LCM] Communications Fault, FailCount= 1
2017-10-06T23:01:20.362Z,1507330880.362 [Rowe_600LCM](ERROR): Communications Fault
2017-10-06T23:01:20.377Z,1507330880.377 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2017-10-06T23:01:20.766Z,1507330880.766 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2017-10-06T23:01:20.943Z,1507330880.943 [Rowe_600LCM](INFO): Powering down
2017-10-06T23:01:21.972Z,1507330881.972 [SBIT](ERROR): Could not read massPosReader_.
2017-10-06T23:01:21.972Z,1507330881.972 [SBIT](FAULT): Control surface position failure.
2017-10-06T23:01:27.847Z,1507330887.847 [SBIT](CRITICAL): SBIT FAILED
2017-10-06T23:01:27.849Z,1507330887.849 [CBIT](INFO): Critical error at 20171006T230127
2017-10-06T23:01:27.863Z,1507330887.863 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2017-10-06T23:01:27.863Z,1507330887.863 [Rowe_600LCM] No Fault, FailCount= 1
2017-10-06T23:01:27.866Z,1507330887.866 [Rowe_600LCM](INFO): Initializing
2017-10-06T23:01:27.867Z,1507330887.867 [Rowe_600LCM](INFO): Checking LCM
2017-10-06T23:01:27.867Z,1507330887.867 [Rowe_600LCM](INFO): LCM OK
2017-10-06T23:01:27.867Z,1507330887.867 [Rowe_600LCM](INFO): Powering up
2017-10-06T23:01:28.014Z,1507330888.014 [MissionManager](IMPORTANT): Started mission Startup
2017-10-06T23:01:28.015Z,1507330888.015 [Startup] Running Loop=1
2017-10-06T23:01:28.015Z,1507330888.015 [Startup](DEBUG): Aggregate::initialize Startup
2017-10-06T23:01:28.015Z,1507330888.015 [Startup:A.GoToSurface] Running Loop=1
2017-10-06T23:01:28.015Z,1507330888.015 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-10-06T23:01:28.016Z,1507330888.016 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-10-06T23:01:28.016Z,1507330888.016 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-10-06T23:01:28.017Z,1507330888.017 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-10-06T23:01:28.017Z,1507330888.017 [Startup:A.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-10-06T23:01:28.017Z,1507330888.017 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-10-06T23:01:28.044Z,1507330888.044 [Startup:StartupSatComms] Running Loop=1
2017-10-06T23:01:28.045Z,1507330888.045 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2017-10-06T23:01:28.045Z,1507330888.045 [Startup:StartupSatComms:A] Running Loop=1
2017-10-06T23:01:28.357Z,1507330888.357 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2017-10-06T23:01:32.237Z,1507330892.237 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-06T23:01:32.413Z,1507330892.413 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 38400 >& /dev/null &
2017-10-06T23:01:32.414Z,1507330892.414 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-06T23:01:32.415Z,1507330892.415 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-06T23:01:32.416Z,1507330892.416 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-06T23:01:33.488Z,1507330893.488 [CommandLine](IMPORTANT): got command show stack
2017-10-06T23:01:33.489Z,1507330893.489 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-06T23:01:33.489Z,1507330893.489 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2017-10-06T23:01:33.490Z,1507330893.490 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A
2017-10-06T23:01:35.113Z,1507330895.113 [BPC1](FAULT): Failed to initialize
2017-10-06T23:01:35.113Z,1507330895.113 [BPC1] Communications Fault, FailCount= 8
2017-10-06T23:01:35.113Z,1507330895.113 [BPC1](ERROR): Communications Fault
2017-10-06T23:01:35.217Z,1507330895.217 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:01:36.396Z,1507330896.396 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:01:36.397Z,1507330896.397 [BPC1] No Fault, FailCount= 8
2017-10-06T23:01:51.927Z,1507330911.927 [BPC1](FAULT): Failed to initialize
2017-10-06T23:01:51.927Z,1507330911.927 [BPC1] Communications Fault, FailCount= 9
2017-10-06T23:01:51.927Z,1507330911.927 [BPC1](ERROR): Communications Fault
2017-10-06T23:01:51.995Z,1507330911.995 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:01:53.218Z,1507330913.218 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:01:53.220Z,1507330913.220 [BPC1] No Fault, FailCount= 9
2017-10-06T23:02:03.535Z,1507330923.535 [CommandLine](IMPORTANT): got command show stack
2017-10-06T23:02:03.536Z,1507330923.536 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-06T23:02:03.536Z,1507330923.536 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2017-10-06T23:02:03.537Z,1507330923.537 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A
2017-10-06T23:02:08.011Z,1507330928.011 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:02:08.011Z,1507330928.011 [Aanderaa_O2] No Fault, FailCount= 3
2017-10-06T23:02:08.709Z,1507330928.709 [BPC1](FAULT): Failed to initialize
2017-10-06T23:02:08.709Z,1507330928.709 [BPC1] Communications Fault, FailCount= 10
2017-10-06T23:02:08.709Z,1507330928.709 [BPC1](ERROR): Communications Fault
2017-10-06T23:02:08.833Z,1507330928.833 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:02:08.834Z,1507330928.834 [CBIT](CRITICAL): Communications Fault in component: BPC1
2017-10-06T23:02:09.225Z,1507330929.225 [CBIT](INFO): Critical error at 20171006T230208
2017-10-06T23:02:09.916Z,1507330929.916 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:02:09.916Z,1507330929.916 [Aanderaa_O2] Data Fault, FailCount= 1
2017-10-06T23:02:09.916Z,1507330929.916 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:02:09.941Z,1507330929.941 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:02:10.435Z,1507330930.435 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:02:11.252Z,1507330931.252 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:02:11.253Z,1507330931.253 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-06T23:02:13.117Z,1507330933.117 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:02:13.117Z,1507330933.117 [Aanderaa_O2] Data Fault, FailCount= 2
2017-10-06T23:02:13.117Z,1507330933.117 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:02:13.211Z,1507330933.211 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:02:13.634Z,1507330933.634 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:02:14.401Z,1507330934.401 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:02:14.401Z,1507330934.401 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-06T23:02:16.317Z,1507330936.317 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:02:16.317Z,1507330936.317 [Aanderaa_O2] Data Fault, FailCount= 3
2017-10-06T23:02:16.317Z,1507330936.317 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:02:16.425Z,1507330936.425 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:02:16.426Z,1507330936.426 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2017-10-06T23:02:16.843Z,1507330936.843 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:02:20.741Z,1507330940.741 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:02:20.741Z,1507330940.741 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2017-10-06T23:02:20.741Z,1507330940.741 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2017-10-06T23:02:20.748Z,1507330940.748 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:02:20.748Z,1507330940.748 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2017-10-06T23:02:20.748Z,1507330940.748 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2017-10-06T23:02:20.800Z,1507330940.800 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2017-10-06T23:02:20.800Z,1507330940.800 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2017-10-06T23:02:21.231Z,1507330941.231 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2017-10-06T23:02:21.231Z,1507330941.231 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2017-10-06T23:02:21.232Z,1507330941.232 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2017-10-06T23:02:21.232Z,1507330941.232 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2017-10-06T23:02:21.579Z,1507330941.579 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-06T23:02:21.579Z,1507330941.579 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:02:21.580Z,1507330941.580 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:02:21.580Z,1507330941.580 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-06T23:02:21.581Z,1507330941.581 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:02:21.581Z,1507330941.581 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:02:27.236Z,1507330947.236 [CommandLine](IMPORTANT): got command show stack
2017-10-06T23:02:27.236Z,1507330947.236 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-06T23:02:27.237Z,1507330947.237 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2017-10-06T23:02:27.237Z,1507330947.237 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A
2017-10-06T23:02:28.242Z,1507330948.242 [Startup:StartupSatComms:A](INFO): Timed out from 2017-10-06T23:01:28.0Z
2017-10-06T23:02:28.242Z,1507330948.242 [Startup:StartupSatComms:A] Stopped
2017-10-06T23:02:28.242Z,1507330948.242 [Startup:StartupSatComms:B] Running Loop=1
2017-10-06T23:02:28.422Z,1507330948.422 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2017-10-06T23:02:36.424Z,1507330956.424 [DataOverHttps](INFO): Sending 203 bytes from file Logs/20171006T224715/Courier0000.lzma
2017-10-06T23:02:37.195Z,1507330957.195 [DataOverHttps](INFO): Moved sent file to Logs/20171006T224715/Courier0000.lzma.bak
2017-10-06T23:02:37.195Z,1507330957.195 [DataOverHttps](INFO): SBD MOMSN=5121578
2017-10-06T23:02:53.270Z,1507330973.270 [DataOverHttps](INFO): Sending 124 bytes from file Logs/20171006T224715/Courier0004.lzma
2017-10-06T23:02:54.056Z,1507330974.056 [DataOverHttps](INFO): Moved sent file to Logs/20171006T224715/Courier0004.lzma.bak
2017-10-06T23:02:54.056Z,1507330974.056 [DataOverHttps](INFO): SBD MOMSN=5121586
2017-10-06T23:03:08.304Z,1507330988.304 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2017-10-06T23:03:08.304Z,1507330988.304 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2017-10-06T23:03:08.575Z,1507330988.575 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2017-10-06T23:03:08.583Z,1507330988.583 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2017-10-06T23:03:08.624Z,1507330988.624 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2017-10-06T23:03:08.656Z,1507330988.656 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2017-10-06T23:03:08.679Z,1507330988.679 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2017-10-06T23:03:08.682Z,1507330988.682 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2017-10-06T23:03:08.695Z,1507330988.695 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2017-10-06T23:03:08.721Z,1507330988.721 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2017-10-06T23:03:08.736Z,1507330988.736 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2017-10-06T23:03:08.756Z,1507330988.756 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2017-10-06T23:03:08.760Z,1507330988.760 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 1.000000 bool
2017-10-06T23:03:08.778Z,1507330988.778 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 bool
2017-10-06T23:03:08.824Z,1507330988.824 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 0.000000 bool
2017-10-06T23:03:08.856Z,1507330988.856 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2017-10-06T23:03:08.861Z,1507330988.861 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2017-10-06T23:03:08.914Z,1507330988.914 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2017-10-06T23:03:08.942Z,1507330988.942 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2017-10-06T23:03:08.958Z,1507330988.958 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2017-10-06T23:03:08.962Z,1507330988.962 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2017-10-06T23:03:08.966Z,1507330988.966 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2017-10-06T23:03:08.982Z,1507330988.982 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2017-10-06T23:03:08.986Z,1507330988.986 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2017-10-06T23:03:08.990Z,1507330988.990 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2017-10-06T23:03:09.038Z,1507330989.038 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2017-10-06T23:03:09.088Z,1507330989.088 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2017-10-06T23:03:09.104Z,1507330989.104 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2017-10-06T23:03:09.140Z,1507330989.140 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2017-10-06T23:03:09.169Z,1507330989.169 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2017-10-06T23:03:09.197Z,1507330989.197 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2017-10-06T23:03:09.252Z,1507330989.252 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2017-10-06T23:03:09.281Z,1507330989.281 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2017-10-06T23:03:09.293Z,1507330989.293 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan arcdeg
2017-10-06T23:03:09.378Z,1507330989.378 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-10-06T23:03:09.461Z,1507330989.461 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2017-10-06T23:03:09.557Z,1507330989.557 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-10-06T23:03:09.656Z,1507330989.656 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Aggregate xmlns="Tethys"
       xmlns:Derivation="Tethys/Derivation"
       xmlns:Science="Tethys/Science"
       xmlns:Sensor="Tethys/Sensor"
       xmlns:Trigger="Tethys/Trigger"
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Derivation http://okeanids.mbari.org/tethys/Xml/Derivation.xsd
                           Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                           Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Science">

    <DefineArg Name="SampleISUS"><Description>
        Set either this or PeakDetectNO3Active to True in order to sample
        Nitrate. EnabledISUS must also be true.
    </Description><False/></DefineArg>

    <DefineArg Name="SampleISUSmaxPitch"><Description>
        Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>60.0</Value></DefineArg>

    <DefineArg Name="SampleISUSminPitch"><Description>
        Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>-60.0</Value></DefineArg>

    <DefineArg Name="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="HighestChlPeakReportActive"><Description>
        Turns on reporting of the highest peak value on yo-yo profiles in a
        horizontal sliding window (of length numProfilesSlidingwindow)
    </Description><False/></DefineArg>

    <DefineArg Name="PatchTracking"><Description>
        If tracking a patch
    </Description><False/></DefineArg>

    <DefineArg Name="FilterWidthHorizontal"><Description>
        Width of boxcar filter applied to yoyo-wise chl peaks to pick out the
        highest peak.
    </Description><Units:count/><Value>3</Value></DefineArg>

    <DefineArg Name="NumProfilesSlidingwindow"><Description>
        Length of horizontal sliding window. The highest yoyo-wise chl peak
        (after low-pass filtering by a filter of length FilterWidthHorizontal)
        within this window.
    </Description><Units:count/><Value>100</Value></DefineArg>

    <DefineArg Name="PeakDetectNO3Active"><Description>
        Turns on peak detection of Nitrate (and turns on ISUS).
    </Description><False/></DefineArg>

    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

    <DefineArg Name="EnabledAanderaaO2"><Description>
        Automatically set to True if the Aanderaa O2 sensor is installed. Set to
        false to disable reading Aandera O2.
    </Description><Science:Aanderaa_O2.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledNeilBrown"><Description>
        Automatically set to true if the Neil Brown CTD is enabled. Set to false
        to disable reading from the Neil Brown.
    </Description><Science:CTD_NeilBrown.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledSeabird"><Description>
        Automatically set to true if the CTD is enabled. Set to false to disable
        reading from the CTD.
    </Description><Science:CTD_Seabird.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledTurbulence_NPS"><Description>
        Automatically set to true if the NPS Turbulence sensor is enabled. Set
        to false to disable reading from the NPS Turbulence sensor.
    </Description><Science:Turbulence_NPS.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsBB2FL"><Description>
        Automatically set to true if the the WetLabs BB2FL is enabled. Set to
        false to disable the WetLabs BB2FL.
    </Description><Science:WetLabsBB2FL.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledISUS"><Description>
        Automatically set to True if ISUS is enabled. Set to false to disable
        ISUS.
    </Description><Science:ISUS.loadAtStartup/></DefineArg>

<!--
    <DefineArg Name="EnabledSeeStar"><Description>
        Automatically set to True if SeeStar/SCPI is enabled. Set false to
        override.
    </Description><Sensor:SCPI.loadAtStartup/></DefineArg>

    <DefineArg Name="SeeStarTimeout"><Description>
        Timeout to trigger/read trigger for SeeStar camera.
    </Description><Sensor:SCPI.sampleTime/></DefineArg>

    <DefineArg Name="SeeStarTriggerDepth"><Description>
        Trigger the camera above this depth.
    </Description><Units:meter/><Value>40.0</Value></DefineArg>
-->

    <DefineArg Name="LowPassWindowLength"><Description>
        Low-pass window length (based on depth sensor sampling interval 0.4
        second) for low-pass filtering.
    </Description><Units:count/><Value>20</Value></DefineArg>

    <DefineArg Name="PeakChlShallowBound"><Description>
        Shallow depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineArg Name="PeakChlDeepBound"><Description>
        Deep depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineOutput Name="PeakChl"><Units:microgram_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3"><Units:micromole_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Depth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Latitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Longitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChl"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlDistance"><Units:degree/><Value>NaN</Value></DefineOutput>

    <Parallel/>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledAanderaaO2"/>
        </While>
        <Universal:mass_concentration_of_oxygen_in_sea_water/>
    </ReadData>

    <ReadData>
        <While>
            <Arg Name="EnabledISUS"/>
            <And><Universal:platform_pitch_angle/><Lt><Arg Name="SampleISUSmaxPitch"/></Lt><And><Universal:platform_pitch_angle/><Gt><Arg Name="SampleISUSminPitch"/></Gt><And><Arg Name="SampleISUS"/><Or><Arg Name="PeakDetectNO3Active"/></Or></And></And></And>
        </While>
        <Universal:mole_concentration_of_nitrate_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
        </While>
        <Universal:sea_water_temperature/>
        <Universal:sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
            <And><Arg Name="UpwardDerivativeOfTemperatureActive"/></And>
        </While>
        <Universal:upward_derivative_of_sea_water_temperature/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledTurbulence_NPS"/>
        </While>
        <Science:Turbulence_NPS.MicroCond/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate  Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_chlorophyll_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakChl"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakChlDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakChl"/><Arg Name="PeakChlDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

        <While>
            <Arg Name="HighestChlPeakReportActive"/>
        </While>

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakChl"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakChlDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakChlLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakChlLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <OutputArg Name="PatchChl"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchChlDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchChlLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchChlLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchChlDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

        <While>
            <Arg Name="PeakDetectNO3Active"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakNO3"/><Arg Name="PeakNO3Depth"/>
        </SendData>

    </Aggregate>

<!--
    <Aggregate Id="RollSeeStar">

        <Description>
            Turn on the SeeStar/SCPI camera.
        </Description>

        <When>
            <Arg Name="EnabledSeeStar"/>
            <And><Universal:depth/><Lt><Arg Name="SeeStarTriggerDepth"/></Lt></And>
        </When>

        <ReadDatum Id="TriggerSeeStar">
            <Timeout Duration="SeeStarTimeout"/>
            <Sensor:SCPI.sampleSCPI/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Arg Name="SeeStarTimeout"/></Setting>
        </Guidance:Wait>

    </Aggregate>
-->

</Aggregate>


2017-10-06T23:03:09.715Z,1507330989.715 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2017-10-06T23:03:11.504Z,1507330991.504 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20171006T225908/Courier0000.lzma
2017-10-06T23:03:12.305Z,1507330992.305 [DataOverHttps](INFO): Moved sent file to Logs/20171006T225908/Courier0000.lzma.bak
2017-10-06T23:03:12.305Z,1507330992.305 [DataOverHttps](INFO): SBD MOMSN=5121592
2017-10-06T23:03:18.543Z,1507330998.543 [NavChartDb](INFO): # of records loaded: 10000
2017-10-06T23:03:28.462Z,1507331008.462 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2017-10-06T23:03:28.462Z,1507331008.462 [Rowe_600LCM] Communications Fault, FailCount= 2
2017-10-06T23:03:28.462Z,1507331008.462 [Rowe_600LCM](ERROR): Communications Fault
2017-10-06T23:03:28.866Z,1507331008.866 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2017-10-06T23:03:29.054Z,1507331009.054 [Rowe_600LCM](INFO): Powering down
2017-10-06T23:03:29.708Z,1507331009.708 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.4 s old, using for 20.0 s.
2017-10-06T23:03:29.733Z,1507331009.733 [Startup:StartupSatComms:B](INFO): Timed out from 2017-10-06T23:02:28.2Z
2017-10-06T23:03:29.733Z,1507331009.733 [Startup:StartupSatComms:B] Stopped
2017-10-06T23:03:29.733Z,1507331009.733 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2017-10-06T23:03:29.733Z,1507331009.733 [Startup:StartupSatComms] Stopped
2017-10-06T23:03:29.733Z,1507331009.733 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2017-10-06T23:03:29.743Z,1507331009.743 [Startup](INFO): Completed Startup
2017-10-06T23:03:29.743Z,1507331009.743 [MissionManager](INFO): Startup is completed.
2017-10-06T23:03:29.743Z,1507331009.743 [MissionManager](INFO): Uninitializing Mission Startup
2017-10-06T23:03:29.744Z,1507331009.744 [Startup] Stopped
2017-10-06T23:03:29.744Z,1507331009.744 [Startup](DEBUG): Aggregate::uninitialize Startup
2017-10-06T23:03:29.744Z,1507331009.744 [Startup:A.GoToSurface] Stopped
2017-10-06T23:03:29.744Z,1507331009.744 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2017-10-06T23:03:29.821Z,1507331009.821 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2017-10-06T23:03:29.900Z,1507331009.900 [DataOverHttps](INFO): Sending 1221 bytes from file Logs/20171006T223606/Express0001.lzma
2017-10-06T23:03:30.005Z,1507331010.005 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.7 s old, using for 20.0 s.
2017-10-06T23:03:30.010Z,1507331010.010 [MissionManager](IMPORTANT): Started mission Science
2017-10-06T23:03:30.010Z,1507331010.010 [Science] Running Loop=1
2017-10-06T23:03:30.026Z,1507331010.026 [Science](DEBUG): Aggregate::initialize Science
2017-10-06T23:03:30.027Z,1507331010.027 [Science:A] Running Loop=1
2017-10-06T23:03:30.027Z,1507331010.027 [Science:B] Running Loop=1
2017-10-06T23:03:30.027Z,1507331010.027 [Science:C] Running Loop=1
2017-10-06T23:03:30.027Z,1507331010.027 [Science:D] Running Loop=1
2017-10-06T23:03:30.027Z,1507331010.027 [Science:E] Running Loop=1
2017-10-06T23:03:30.027Z,1507331010.027 [Science:F] Running Loop=1
2017-10-06T23:03:30.027Z,1507331010.027 [Science:PeakDetectChl] Running Loop=1
2017-10-06T23:03:30.027Z,1507331010.027 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2017-10-06T23:03:30.028Z,1507331010.028 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2017-10-06T23:03:30.028Z,1507331010.028 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-10-06T23:03:30.037Z,1507331010.037 [Science:HighestChlPeakReport] Running Loop=1
2017-10-06T23:03:30.037Z,1507331010.037 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2017-10-06T23:03:30.037Z,1507331010.037 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2017-10-06T23:03:30.037Z,1507331010.037 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2017-10-06T23:03:30.046Z,1507331010.046 [Science:PeakDetectNO3] Running Loop=1
2017-10-06T23:03:30.046Z,1507331010.046 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2017-10-06T23:03:30.047Z,1507331010.047 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2017-10-06T23:03:30.047Z,1507331010.047 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-10-06T23:03:30.055Z,1507331010.055 [Science:PeakDetectNO3] Stopped
2017-10-06T23:03:30.056Z,1507331010.056 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2017-10-06T23:03:30.056Z,1507331010.056 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2017-10-06T23:03:30.059Z,1507331010.059 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-10-06T23:03:30.059Z,1507331010.059 [Science:HighestChlPeakReport] Stopped
2017-10-06T23:03:30.059Z,1507331010.059 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2017-10-06T23:03:30.059Z,1507331010.059 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2017-10-06T23:03:30.059Z,1507331010.059 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2017-10-06T23:03:30.060Z,1507331010.060 [Science:PeakDetectChl] Stopped
2017-10-06T23:03:30.060Z,1507331010.060 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2017-10-06T23:03:30.060Z,1507331010.060 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2017-10-06T23:03:30.060Z,1507331010.060 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-10-06T23:03:30.060Z,1507331010.060 [Science:F] Running Loop=1
2017-10-06T23:03:30.061Z,1507331010.061 [Science:F](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2017-10-06T23:03:30.073Z,1507331010.073 [Science:E] Stopped
2017-10-06T23:03:30.073Z,1507331010.073 [Science:D] Stopped
2017-10-06T23:03:30.073Z,1507331010.073 [Science:C] Running Loop=1
2017-10-06T23:03:30.074Z,1507331010.074 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2017-10-06T23:03:30.075Z,1507331010.075 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2017-10-06T23:03:30.078Z,1507331010.078 [Science:B] Stopped
2017-10-06T23:03:30.078Z,1507331010.078 [Science:A] Running Loop=1
2017-10-06T23:03:30.083Z,1507331010.083 [Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2017-10-06T23:03:30.248Z,1507331010.248 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:03:30.248Z,1507331010.248 [WetLabsBB2FL](INFO): Powering up
2017-10-06T23:03:30.307Z,1507331010.307 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T23:03:30.310Z,1507331010.310 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:03:30.331Z,1507331010.331 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2017-10-06T23:03:30.390Z,1507331010.390 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2017-10-06T23:03:30.390Z,1507331010.390 [Rowe_600LCM] No Fault, FailCount= 2
2017-10-06T23:03:30.655Z,1507331010.655 [DataOverHttps](INFO): Moved sent file to Logs/20171006T223606/Express0001.lzma.bak
2017-10-06T23:03:30.655Z,1507331010.655 [DataOverHttps](INFO): SBD MOMSN=5121600
2017-10-06T23:03:30.673Z,1507331010.673 [Rowe_600LCM](INFO): Initializing
2017-10-06T23:03:30.673Z,1507331010.673 [Rowe_600LCM](INFO): Checking LCM
2017-10-06T23:03:30.673Z,1507331010.673 [Rowe_600LCM](INFO): LCM OK
2017-10-06T23:03:30.674Z,1507331010.674 [Rowe_600LCM](INFO): Powering up
2017-10-06T23:03:30.763Z,1507331010.763 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2017-10-06T23:03:31.135Z,1507331011.135 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2017-10-06T23:03:31.538Z,1507331011.538 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2017-10-06T23:03:34.973Z,1507331014.973 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-06T23:03:35.163Z,1507331015.163 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 38400 >& /dev/null &
2017-10-06T23:03:35.165Z,1507331015.165 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-06T23:03:35.165Z,1507331015.165 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-06T23:03:35.167Z,1507331015.167 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-06T23:03:41.689Z,1507331021.689 [CommandLine](IMPORTANT): got command show stack
2017-10-06T23:03:41.689Z,1507331021.689 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-06T23:03:41.696Z,1507331021.696 [Science](IMPORTANT): Priority 0: Science:A
2017-10-06T23:03:41.696Z,1507331021.696 [Science](IMPORTANT): Priority 1: Science:C
2017-10-06T23:03:41.696Z,1507331021.696 [Science](IMPORTANT): Priority 2: Science:F
2017-10-06T23:03:50.900Z,1507331030.900 [CTD_NeilBrown](ERROR): Bad response: ‚‹
£6ì=ø~�>õö?{íÑ[z�­�466ƒ##²#òBREAK

Copyright (c) 2009-2016 Rowe Technologies Inc. All rights reserved.
Direct Reading
DP600 
SN: 01l00000000000000000000000000199
FW: 00.02.96 Aug 19 2016 13:40:02
$PRTI01
2017-10-06T23:03:50.901Z,1507331030.901 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-06T23:03:50.901Z,1507331030.901 [CTD_NeilBrown] Communications Fault, FailCount= 1
2017-10-06T23:03:50.901Z,1507331030.901 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-06T23:03:50.966Z,1507331030.966 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-06T23:03:51.347Z,1507331031.347 [CTD_NeilBrown](INFO): Powering down
2017-10-06T23:03:52.948Z,1507331032.948 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-06T23:03:52.948Z,1507331032.948 [CTD_NeilBrown] No Fault, FailCount= 1
2017-10-06T23:03:52.967Z,1507331032.967 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T23:03:52.967Z,1507331032.967 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:04:01.203Z,1507331041.203 [CTD_NeilBrown](ERROR): serial buffer full
2017-10-06T23:04:01.203Z,1507331041.203 [CTD_NeilBrown] Communications Fault, FailCount= 2
2017-10-06T23:04:01.203Z,1507331041.203 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-06T23:04:01.205Z,1507331041.205 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-06T23:04:01.473Z,1507331041.473 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-06T23:04:01.611Z,1507331041.611 [CTD_NeilBrown](INFO): Powering down
2017-10-06T23:04:02.909Z,1507331042.909 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-06T23:04:02.909Z,1507331042.909 [CTD_NeilBrown] No Fault, FailCount= 2
2017-10-06T23:04:03.227Z,1507331043.227 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T23:04:03.227Z,1507331043.227 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:04:09.752Z,1507331049.752 [CommandLine](IMPORTANT): got command report touch mass_concentration_of_chlorophyll_in_sea_water
2017-10-06T23:04:10.491Z,1507331050.491 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:04:11.332Z,1507331051.332 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:04:12.098Z,1507331052.098 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:04:12.936Z,1507331052.936 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:13.156Z,1507331053.156 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T23:04:13.199Z,1507331053.199 [CTD_NeilBrown](DEBUG): serial timeout
2017-10-06T23:04:13.199Z,1507331053.199 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-06T23:04:13.199Z,1507331053.199 [CTD_NeilBrown] Communications Fault, FailCount= 3
2017-10-06T23:04:13.199Z,1507331053.199 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-06T23:04:13.349Z,1507331053.349 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-06T23:04:13.349Z,1507331053.349 [CBIT](FAULT): Communications Fault in component: CTD_NeilBrown
2017-10-06T23:04:13.695Z,1507331053.695 [CTD_NeilBrown](INFO): Powering down
2017-10-06T23:04:13.727Z,1507331053.727 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:14.895Z,1507331054.895 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:15.718Z,1507331055.718 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:04:16.531Z,1507331056.531 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:18.115Z,1507331058.115 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:19.315Z,1507331059.315 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:20.131Z,1507331060.131 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:20.887Z,1507331060.887 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:22.518Z,1507331062.518 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:04:23.344Z,1507331063.344 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:24.525Z,1507331064.525 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:25.316Z,1507331065.316 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:26.076Z,1507331066.076 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:27.728Z,1507331067.728 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:28.885Z,1507331068.885 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:29.699Z,1507331069.699 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:30.511Z,1507331070.511 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:31.321Z,1507331071.321 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:38.656Z,1507331078.656 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:04:39.629Z,1507331079.629 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:39.669Z,1507331079.669 [NavChartDb](INFO): # of records loaded: 15000
2017-10-06T23:04:40.406Z,1507331080.406 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:41.187Z,1507331081.187 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:41.982Z,1507331081.982 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:42.764Z,1507331082.764 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:42.897Z,1507331082.897 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T23:04:44.003Z,1507331084.003 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:04:44.393Z,1507331084.393 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:45.593Z,1507331085.593 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:04:46.394Z,1507331086.394 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:04:46.394Z,1507331086.394 [Aanderaa_O2] No Fault, FailCount= 3
2017-10-06T23:04:46.405Z,1507331086.405 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.321300 ug/l
2017-10-06T23:04:47.208Z,1507331087.208 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:04:48.309Z,1507331088.309 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:04:48.309Z,1507331088.309 [Aanderaa_O2] Data Fault, FailCount= 1
2017-10-06T23:04:48.309Z,1507331088.309 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:04:48.446Z,1507331088.446 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:04:48.831Z,1507331088.831 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:04:48.919Z,1507331088.919 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:49.617Z,1507331089.617 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:04:49.617Z,1507331089.617 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-06T23:04:50.024Z,1507331090.024 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:50.819Z,1507331090.819 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:51.516Z,1507331091.516 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:04:51.516Z,1507331091.516 [Aanderaa_O2] Data Fault, FailCount= 2
2017-10-06T23:04:51.516Z,1507331091.516 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:04:51.627Z,1507331091.627 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:04:51.629Z,1507331091.629 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:52.018Z,1507331092.018 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:04:52.457Z,1507331092.457 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:04:52.812Z,1507331092.812 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:04:52.813Z,1507331092.813 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-06T23:04:54.392Z,1507331094.392 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:04:54.707Z,1507331094.707 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:04:54.707Z,1507331094.707 [Aanderaa_O2] Data Fault, FailCount= 3
2017-10-06T23:04:54.707Z,1507331094.707 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:04:54.757Z,1507331094.757 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:04:54.757Z,1507331094.757 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2017-10-06T23:04:55.219Z,1507331095.219 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:04:55.304Z,1507331095.304 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:04:55.304Z,1507331095.304 [MassServo] No Fault, FailCount= 5
2017-10-06T23:04:55.309Z,1507331095.309 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:56.013Z,1507331096.013 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:04:57.595Z,1507331097.595 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:04:58.376Z,1507331098.376 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.642600 ug/l
2017-10-06T23:04:58.783Z,1507331098.783 [MassServo](FAULT): Overload Error
2017-10-06T23:04:58.783Z,1507331098.783 [MassServo] Hardware Fault, FailCount= 1
2017-10-06T23:04:58.783Z,1507331098.783 [MassServo](ERROR): Hardware Fault
2017-10-06T23:04:58.789Z,1507331098.789 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:04:59.178Z,1507331099.178 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:04:59.178Z,1507331099.178 [MassServo](INFO): Powering down
2017-10-06T23:04:59.569Z,1507331099.569 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 47.838003 ug/l
2017-10-06T23:04:59.947Z,1507331099.947 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:05:00.069Z,1507331100.069 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:05:00.085Z,1507331100.085 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:05:00.085Z,1507331100.085 [MassServo] No Fault, FailCount= 1
2017-10-06T23:05:03.999Z,1507331103.999 [MassServo](FAULT): Overload Error
2017-10-06T23:05:03.999Z,1507331103.999 [MassServo] Hardware Fault, FailCount= 2
2017-10-06T23:05:03.999Z,1507331103.999 [MassServo](ERROR): Hardware Fault
2017-10-06T23:05:04.005Z,1507331104.005 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:05:04.341Z,1507331104.341 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:05:04.342Z,1507331104.342 [MassServo](INFO): Powering down
2017-10-06T23:05:05.153Z,1507331105.153 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:05:05.269Z,1507331105.269 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:05:05.278Z,1507331105.278 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:05:05.278Z,1507331105.278 [MassServo] No Fault, FailCount= 2
2017-10-06T23:05:09.206Z,1507331109.206 [MassServo](FAULT): Overload Error
2017-10-06T23:05:09.207Z,1507331109.207 [MassServo] Hardware Fault, FailCount= 3
2017-10-06T23:05:09.207Z,1507331109.207 [MassServo](ERROR): Hardware Fault
2017-10-06T23:05:09.212Z,1507331109.212 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:05:09.579Z,1507331109.579 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:05:09.579Z,1507331109.579 [MassServo](INFO): Powering down
2017-10-06T23:05:10.341Z,1507331110.341 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:05:10.470Z,1507331110.470 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:05:10.488Z,1507331110.488 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:05:10.488Z,1507331110.488 [MassServo] No Fault, FailCount= 3
2017-10-06T23:05:13.995Z,1507331113.995 [MassServo](FAULT): Overload Error
2017-10-06T23:05:13.995Z,1507331113.995 [MassServo] Hardware Fault, FailCount= 4
2017-10-06T23:05:13.996Z,1507331113.996 [MassServo](ERROR): Hardware Fault
2017-10-06T23:05:14.025Z,1507331114.025 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:05:14.355Z,1507331114.355 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:05:14.355Z,1507331114.355 [MassServo](INFO): Powering down
2017-10-06T23:05:15.210Z,1507331115.210 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:05:15.331Z,1507331115.331 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:05:15.337Z,1507331115.337 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:05:15.337Z,1507331115.337 [MassServo] No Fault, FailCount= 4
2017-10-06T23:05:16.056Z,1507331116.056 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 5.271700 ug/l
2017-10-06T23:05:17.174Z,1507331117.174 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:05:17.986Z,1507331117.986 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:05:18.813Z,1507331118.813 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:05:19.211Z,1507331119.211 [MassServo](FAULT): Overload Error
2017-10-06T23:05:19.211Z,1507331119.211 [MassServo] Hardware Fault, FailCount= 5
2017-10-06T23:05:19.211Z,1507331119.211 [MassServo](ERROR): Hardware Fault
2017-10-06T23:05:19.216Z,1507331119.216 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:05:19.217Z,1507331119.217 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2017-10-06T23:05:19.576Z,1507331119.576 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:05:19.576Z,1507331119.576 [MassServo](INFO): Powering down
2017-10-06T23:05:19.580Z,1507331119.580 [CBIT](INFO): Critical error at 20171006T230519
2017-10-06T23:05:19.580Z,1507331119.580 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2017-10-06T23:05:19.927Z,1507331119.927 [MissionManager](INFO): MissionManager is completed.
2017-10-06T23:05:19.927Z,1507331119.927 [MissionManager](INFO): Uninitializing Mission Science
2017-10-06T23:05:19.927Z,1507331119.927 [Science] Stopped
2017-10-06T23:05:19.927Z,1507331119.927 [Science](DEBUG): Aggregate::uninitialize Science
2017-10-06T23:05:19.927Z,1507331119.927 [Science:A] Stopped
2017-10-06T23:05:19.927Z,1507331119.927 [Science:C] Stopped
2017-10-06T23:05:19.927Z,1507331119.927 [Science:F] Stopped
2017-10-06T23:05:19.988Z,1507331119.988 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:05:20.326Z,1507331120.326 [MissionManager](IMPORTANT): Started mission Default
2017-10-06T23:05:20.330Z,1507331120.330 [Default] Running Loop=1
2017-10-06T23:05:20.331Z,1507331120.331 [Default](DEBUG): Aggregate::initialize Default
2017-10-06T23:05:20.331Z,1507331120.331 [Default:B.GoToSurface] Running Loop=1
2017-10-06T23:05:20.331Z,1507331120.331 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-10-06T23:05:20.331Z,1507331120.331 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-10-06T23:05:20.331Z,1507331120.331 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-10-06T23:05:20.332Z,1507331120.332 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-10-06T23:05:20.332Z,1507331120.332 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-10-06T23:05:20.332Z,1507331120.332 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-10-06T23:05:20.333Z,1507331120.333 [Default:A.Wait] Running Loop=1
2017-10-06T23:05:20.333Z,1507331120.333 [Default:A.Wait](DEBUG): Initialize Wait Component.
2017-10-06T23:05:20.399Z,1507331120.399 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:05:20.521Z,1507331120.521 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:05:21.237Z,1507331121.237 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:05:21.315Z,1507331121.315 [WetLabsBB2FL](INFO): Powering down
2017-10-06T23:05:21.934Z,1507331121.934 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:05:21.935Z,1507331121.935 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2017-10-06T23:05:21.935Z,1507331121.935 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2017-10-06T23:05:21.941Z,1507331121.941 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:05:21.941Z,1507331121.941 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2017-10-06T23:05:21.941Z,1507331121.941 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2017-10-06T23:05:22.007Z,1507331122.007 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2017-10-06T23:05:22.009Z,1507331122.009 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2017-10-06T23:05:22.364Z,1507331122.364 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2017-10-06T23:05:22.364Z,1507331122.364 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2017-10-06T23:05:22.364Z,1507331122.364 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2017-10-06T23:05:22.365Z,1507331122.365 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2017-10-06T23:05:22.733Z,1507331122.733 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-06T23:05:22.734Z,1507331122.734 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:05:22.734Z,1507331122.734 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:05:22.735Z,1507331122.735 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-06T23:05:22.735Z,1507331122.735 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:05:22.735Z,1507331122.735 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:05:30.694Z,1507331130.694 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2017-10-06T23:05:30.694Z,1507331130.694 [Rowe_600LCM] Communications Fault, FailCount= 3
2017-10-06T23:05:30.694Z,1507331130.694 [Rowe_600LCM](ERROR): Communications Fault
2017-10-06T23:05:30.755Z,1507331130.755 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s.
2017-10-06T23:05:30.810Z,1507331130.810 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2017-10-06T23:05:31.098Z,1507331131.098 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2017-10-06T23:05:31.148Z,1507331131.148 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s.
2017-10-06T23:05:31.325Z,1507331131.325 [Rowe_600LCM](INFO): Powering down
2017-10-06T23:05:31.527Z,1507331131.527 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2017-10-06T23:05:31.962Z,1507331131.962 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2017-10-06T23:05:32.195Z,1507331132.195 [CommandLine](IMPORTANT): got command failComponent
2017-10-06T23:05:32.195Z,1507331132.195 [CommandLine](IMPORTANT): Failed components:
2017-10-06T23:05:32.196Z,1507331132.196 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2017-10-06T23:05:32.196Z,1507331132.196 [CommandLine](IMPORTANT): Rowe_600LCM: Communications Fault
2017-10-06T23:05:32.196Z,1507331132.196 [CommandLine](IMPORTANT): BPC1: Communications Fault
2017-10-06T23:05:32.196Z,1507331132.196 [CommandLine](IMPORTANT): Aanderaa_O2: Data Fault
2017-10-06T23:05:32.197Z,1507331132.197 [CommandLine](IMPORTANT): CTD_NeilBrown: Communications Fault
2017-10-06T23:05:32.197Z,1507331132.197 [CommandLine](IMPORTANT): MassServo: Hardware Fault
2017-10-06T23:05:37.733Z,1507331137.733 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.4 s old, using for 20.0 s.
2017-10-06T23:05:37.737Z,1507331137.737 [Default:A.Wait](INFO): Done Waiting.
2017-10-06T23:05:37.737Z,1507331137.737 [Default:A.Wait] Stopped
2017-10-06T23:05:37.737Z,1507331137.737 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2017-10-06T23:05:37.781Z,1507331137.781 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2017-10-06T23:05:37.781Z,1507331137.781 [Rowe_600LCM] No Fault, FailCount= 3
2017-10-06T23:05:37.790Z,1507331137.790 [Rowe_600LCM](INFO): Initializing
2017-10-06T23:05:37.791Z,1507331137.791 [Rowe_600LCM](INFO): Checking LCM
2017-10-06T23:05:37.791Z,1507331137.791 [Rowe_600LCM](INFO): LCM OK
2017-10-06T23:05:37.791Z,1507331137.791 [Rowe_600LCM](INFO): Powering up
2017-10-06T23:05:37.887Z,1507331137.887 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2017-10-06T23:05:37.897Z,1507331137.897 [Default:CheckIn] Running Loop=1
2017-10-06T23:05:37.897Z,1507331137.897 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-10-06T23:05:37.897Z,1507331137.897 [Default:CheckIn:Read_GPS] Running Loop=1
2017-10-06T23:05:38.254Z,1507331138.254 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.9 s old, using for 20.0 s.
2017-10-06T23:05:38.290Z,1507331138.290 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2017-10-06T23:05:38.661Z,1507331138.661 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.3 s old, using for 20.0 s.
2017-10-06T23:05:39.050Z,1507331139.050 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.7 s old, using for 20.0 s.
2017-10-06T23:05:39.465Z,1507331139.465 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.1 s old, using for 20.0 s.
2017-10-06T23:05:39.871Z,1507331139.871 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.5 s old, using for 20.0 s.
2017-10-06T23:05:40.269Z,1507331140.269 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.9 s old, using for 20.0 s.
2017-10-06T23:05:40.668Z,1507331140.668 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.3 s old, using for 20.0 s.
2017-10-06T23:05:41.116Z,1507331141.116 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2017-10-06T23:05:41.481Z,1507331141.481 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2017-10-06T23:05:41.921Z,1507331141.921 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2017-10-06T23:05:42.050Z,1507331142.050 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-06T23:05:42.139Z,1507331142.139 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 38400 >& /dev/null &
2017-10-06T23:05:42.140Z,1507331142.140 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-06T23:05:42.141Z,1507331142.141 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-06T23:05:42.142Z,1507331142.142 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-06T23:05:42.315Z,1507331142.315 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2017-10-06T23:05:53.075Z,1507331153.075 [CommandLine](IMPORTANT): got command failComponent
2017-10-06T23:05:53.075Z,1507331153.075 [CommandLine](IMPORTANT): Failed components:
2017-10-06T23:05:53.076Z,1507331153.076 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2017-10-06T23:05:53.076Z,1507331153.076 [CommandLine](IMPORTANT): BPC1: Communications Fault
2017-10-06T23:05:53.076Z,1507331153.076 [CommandLine](IMPORTANT): Aanderaa_O2: Data Fault
2017-10-06T23:05:53.076Z,1507331153.076 [CommandLine](IMPORTANT): CTD_NeilBrown: Communications Fault
2017-10-06T23:05:53.076Z,1507331153.076 [CommandLine](IMPORTANT): MassServo: Hardware Fault
2017-10-06T23:06:11.996Z,1507331171.996 [CommandLine](IMPORTANT): got command configSet MassServo.loadAtStartup 0.000000 bool persist
2017-10-06T23:06:11.997Z,1507331171.997 [CommandLine](IMPORTANT): configSet MassServo.loadAtStartup requires a restart to take effect.
2017-10-06T23:06:22.347Z,1507331182.347 [CommandLine](IMPORTANT): got command configSet DropWeight.loadAtStartup 0.000000 bool persist
2017-10-06T23:06:22.348Z,1507331182.348 [CommandLine](IMPORTANT): configSet DropWeight.loadAtStartup requires a restart to take effect.
2017-10-06T23:06:33.835Z,1507331193.835 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2017-10-06T23:06:33.836Z,1507331193.836 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2017-10-06T23:06:34.144Z,1507331194.144 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2017-10-06T23:06:34.151Z,1507331194.151 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2017-10-06T23:06:34.153Z,1507331194.153 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2017-10-06T23:06:34.165Z,1507331194.165 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2017-10-06T23:06:34.171Z,1507331194.171 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2017-10-06T23:06:34.173Z,1507331194.173 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2017-10-06T23:06:34.204Z,1507331194.204 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2017-10-06T23:06:34.227Z,1507331194.227 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2017-10-06T23:06:34.234Z,1507331194.234 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2017-10-06T23:06:34.236Z,1507331194.236 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2017-10-06T23:06:34.279Z,1507331194.279 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 1.000000 bool
2017-10-06T23:06:34.294Z,1507331194.294 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 bool
2017-10-06T23:06:34.297Z,1507331194.297 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 0.000000 bool
2017-10-06T23:06:34.308Z,1507331194.308 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2017-10-06T23:06:34.315Z,1507331194.315 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2017-10-06T23:06:34.339Z,1507331194.339 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2017-10-06T23:06:34.363Z,1507331194.363 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2017-10-06T23:06:34.365Z,1507331194.365 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2017-10-06T23:06:34.377Z,1507331194.377 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2017-10-06T23:06:34.384Z,1507331194.384 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2017-10-06T23:06:34.386Z,1507331194.386 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2017-10-06T23:06:34.401Z,1507331194.401 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2017-10-06T23:06:34.411Z,1507331194.411 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2017-10-06T23:06:34.414Z,1507331194.414 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2017-10-06T23:06:34.452Z,1507331194.452 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2017-10-06T23:06:34.464Z,1507331194.464 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2017-10-06T23:06:34.486Z,1507331194.486 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2017-10-06T23:06:34.489Z,1507331194.489 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2017-10-06T23:06:34.516Z,1507331194.516 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2017-10-06T23:06:34.535Z,1507331194.535 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2017-10-06T23:06:34.538Z,1507331194.538 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2017-10-06T23:06:34.540Z,1507331194.540 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan arcdeg
2017-10-06T23:06:34.678Z,1507331194.678 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-10-06T23:06:34.719Z,1507331194.719 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2017-10-06T23:06:34.788Z,1507331194.788 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-10-06T23:06:34.865Z,1507331194.865 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Aggregate xmlns="Tethys"
       xmlns:Derivation="Tethys/Derivation"
       xmlns:Science="Tethys/Science"
       xmlns:Sensor="Tethys/Sensor"
       xmlns:Trigger="Tethys/Trigger"
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Derivation http://okeanids.mbari.org/tethys/Xml/Derivation.xsd
                           Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                           Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Science">

    <DefineArg Name="SampleISUS"><Description>
        Set either this or PeakDetectNO3Active to True in order to sample
        Nitrate. EnabledISUS must also be true.
    </Description><False/></DefineArg>

    <DefineArg Name="SampleISUSmaxPitch"><Description>
        Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>60.0</Value></DefineArg>

    <DefineArg Name="SampleISUSminPitch"><Description>
        Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>-60.0</Value></DefineArg>

    <DefineArg Name="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="HighestChlPeakReportActive"><Description>
        Turns on reporting of the highest peak value on yo-yo profiles in a
        horizontal sliding window (of length numProfilesSlidingwindow)
    </Description><False/></DefineArg>

    <DefineArg Name="PatchTracking"><Description>
        If tracking a patch
    </Description><False/></DefineArg>

    <DefineArg Name="FilterWidthHorizontal"><Description>
        Width of boxcar filter applied to yoyo-wise chl peaks to pick out the
        highest peak.
    </Description><Units:count/><Value>3</Value></DefineArg>

    <DefineArg Name="NumProfilesSlidingwindow"><Description>
        Length of horizontal sliding window. The highest yoyo-wise chl peak
        (after low-pass filtering by a filter of length FilterWidthHorizontal)
        within this window.
    </Description><Units:count/><Value>100</Value></DefineArg>

    <DefineArg Name="PeakDetectNO3Active"><Description>
        Turns on peak detection of Nitrate (and turns on ISUS).
    </Description><False/></DefineArg>

    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

    <DefineArg Name="EnabledAanderaaO2"><Description>
        Automatically set to True if the Aanderaa O2 sensor is installed. Set to
        false to disable reading Aandera O2.
    </Description><Science:Aanderaa_O2.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledNeilBrown"><Description>
        Automatically set to true if the Neil Brown CTD is enabled. Set to false
        to disable reading from the Neil Brown.
    </Description><Science:CTD_NeilBrown.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledSeabird"><Description>
        Automatically set to true if the CTD is enabled. Set to false to disable
        reading from the CTD.
    </Description><Science:CTD_Seabird.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledTurbulence_NPS"><Description>
        Automatically set to true if the NPS Turbulence sensor is enabled. Set
        to false to disable reading from the NPS Turbulence sensor.
    </Description><Science:Turbulence_NPS.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsBB2FL"><Description>
        Automatically set to true if the the WetLabs BB2FL is enabled. Set to
        false to disable the WetLabs BB2FL.
    </Description><Science:WetLabsBB2FL.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledISUS"><Description>
        Automatically set to True if ISUS is enabled. Set to false to disable
        ISUS.
    </Description><Science:ISUS.loadAtStartup/></DefineArg>

<!--
    <DefineArg Name="EnabledSeeStar"><Description>
        Automatically set to True if SeeStar/SCPI is enabled. Set false to
        override.
    </Description><Sensor:SCPI.loadAtStartup/></DefineArg>

    <DefineArg Name="SeeStarTimeout"><Description>
        Timeout to trigger/read trigger for SeeStar camera.
    </Description><Sensor:SCPI.sampleTime/></DefineArg>

    <DefineArg Name="SeeStarTriggerDepth"><Description>
        Trigger the camera above this depth.
    </Description><Units:meter/><Value>40.0</Value></DefineArg>
-->

    <DefineArg Name="LowPassWindowLength"><Description>
        Low-pass window length (based on depth sensor sampling interval 0.4
        second) for low-pass filtering.
    </Description><Units:count/><Value>20</Value></DefineArg>

    <DefineArg Name="PeakChlShallowBound"><Description>
        Shallow depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineArg Name="PeakChlDeepBound"><Description>
        Deep depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineOutput Name="PeakChl"><Units:microgram_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3"><Units:micromole_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Depth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Latitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Longitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChl"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlDistance"><Units:degree/><Value>NaN</Value></DefineOutput>

    <Parallel/>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledAanderaaO2"/>
        </While>
        <Universal:mass_concentration_of_oxygen_in_sea_water/>
    </ReadData>

    <ReadData>
        <While>
            <Arg Name="EnabledISUS"/>
            <And><Universal:platform_pitch_angle/><Lt><Arg Name="SampleISUSmaxPitch"/></Lt><And><Universal:platform_pitch_angle/><Gt><Arg Name="SampleISUSminPitch"/></Gt><And><Arg Name="SampleISUS"/><Or><Arg Name="PeakDetectNO3Active"/></Or></And></And></And>
        </While>
        <Universal:mole_concentration_of_nitrate_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
        </While>
        <Universal:sea_water_temperature/>
        <Universal:sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
            <And><Arg Name="UpwardDerivativeOfTemperatureActive"/></And>
        </While>
        <Universal:upward_derivative_of_sea_water_temperature/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledTurbulence_NPS"/>
        </While>
        <Science:Turbulence_NPS.MicroCond/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate  Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_chlorophyll_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakChl"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakChlDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakChl"/><Arg Name="PeakChlDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

        <While>
            <Arg Name="HighestChlPeakReportActive"/>
        </While>

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakChl"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakChlDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakChlLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakChlLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <OutputArg Name="PatchChl"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchChlDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchChlLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchChlLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchChlDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

        <While>
            <Arg Name="PeakDetectNO3Active"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakNO3"/><Arg Name="PeakNO3Depth"/>
        </SendData>

    </Aggregate>

<!--
    <Aggregate Id="RollSeeStar">

        <Description>
            Turn on the SeeStar/SCPI camera.
        </Description>

        <When>
            <Arg Name="EnabledSeeStar"/>
            <And><Universal:depth/><Lt><Arg Name="SeeStarTriggerDepth"/></Lt></And>
        </When>

        <ReadDatum Id="TriggerSeeStar">
            <Timeout Duration="SeeStarTimeout"/>
            <Sensor:SCPI.sampleSCPI/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Arg Name="SeeStarTimeout"/></Setting>
        </Guidance:Wait>

    </Aggregate>
-->

</Aggregate>


2017-10-06T23:06:34.943Z,1507331194.943 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2017-10-06T23:06:39.042Z,1507331199.042 [Default] Stopped
2017-10-06T23:06:39.042Z,1507331199.042 [Default](DEBUG): Aggregate::uninitialize Default
2017-10-06T23:06:39.043Z,1507331199.043 [Default:B.GoToSurface] Stopped
2017-10-06T23:06:39.043Z,1507331199.043 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2017-10-06T23:06:39.043Z,1507331199.043 [Default:CheckIn] Stopped
2017-10-06T23:06:39.043Z,1507331199.043 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-10-06T23:06:39.043Z,1507331199.043 [Default:CheckIn:Read_GPS] Stopped
2017-10-06T23:06:39.043Z,1507331199.043 [MissionManager](IMPORTANT): Started mission Science
2017-10-06T23:06:39.043Z,1507331199.043 [Science] Running Loop=1
2017-10-06T23:06:39.043Z,1507331199.043 [Science](DEBUG): Aggregate::initialize Science
2017-10-06T23:06:39.044Z,1507331199.044 [Science:A] Running Loop=1
2017-10-06T23:06:39.044Z,1507331199.044 [Science:B] Running Loop=1
2017-10-06T23:06:39.044Z,1507331199.044 [Science:C] Running Loop=1
2017-10-06T23:06:39.044Z,1507331199.044 [Science:D] Running Loop=1
2017-10-06T23:06:39.044Z,1507331199.044 [Science:E] Running Loop=1
2017-10-06T23:06:39.044Z,1507331199.044 [Science:F] Running Loop=1
2017-10-06T23:06:39.044Z,1507331199.044 [Science:PeakDetectChl] Running Loop=1
2017-10-06T23:06:39.044Z,1507331199.044 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2017-10-06T23:06:39.045Z,1507331199.045 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2017-10-06T23:06:39.045Z,1507331199.045 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-10-06T23:06:39.051Z,1507331199.051 [Science:HighestChlPeakReport] Running Loop=1
2017-10-06T23:06:39.054Z,1507331199.054 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2017-10-06T23:06:39.054Z,1507331199.054 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2017-10-06T23:06:39.058Z,1507331199.058 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2017-10-06T23:06:39.063Z,1507331199.063 [Science:PeakDetectNO3] Running Loop=1
2017-10-06T23:06:39.065Z,1507331199.065 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2017-10-06T23:06:39.065Z,1507331199.065 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2017-10-06T23:06:39.071Z,1507331199.071 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-10-06T23:06:39.089Z,1507331199.089 [Science:PeakDetectNO3] Stopped
2017-10-06T23:06:39.089Z,1507331199.089 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2017-10-06T23:06:39.089Z,1507331199.089 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2017-10-06T23:06:39.090Z,1507331199.090 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-10-06T23:06:39.091Z,1507331199.091 [Science:HighestChlPeakReport] Stopped
2017-10-06T23:06:39.091Z,1507331199.091 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2017-10-06T23:06:39.091Z,1507331199.091 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2017-10-06T23:06:39.092Z,1507331199.092 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2017-10-06T23:06:39.093Z,1507331199.093 [Science:PeakDetectChl] Stopped
2017-10-06T23:06:39.093Z,1507331199.093 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2017-10-06T23:06:39.095Z,1507331199.095 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2017-10-06T23:06:39.095Z,1507331199.095 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-10-06T23:06:39.095Z,1507331199.095 [Science:F] Running Loop=1
2017-10-06T23:06:39.095Z,1507331199.095 [Science:F](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2017-10-06T23:06:39.096Z,1507331199.096 [Science:E] Stopped
2017-10-06T23:06:39.096Z,1507331199.096 [Science:D] Stopped
2017-10-06T23:06:39.096Z,1507331199.096 [Science:C] Running Loop=1
2017-10-06T23:06:39.097Z,1507331199.097 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2017-10-06T23:06:39.098Z,1507331199.098 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2017-10-06T23:06:39.103Z,1507331199.103 [Science:B] Stopped
2017-10-06T23:06:39.103Z,1507331199.103 [Science:A] Running Loop=1
2017-10-06T23:06:39.104Z,1507331199.104 [Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2017-10-06T23:06:39.321Z,1507331199.321 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:06:39.322Z,1507331199.322 [WetLabsBB2FL](INFO): Powering up
2017-10-06T23:06:43.248Z,1507331203.248 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-06T23:06:43.248Z,1507331203.248 [CTD_NeilBrown] No Fault, FailCount= 3
2017-10-06T23:06:43.334Z,1507331203.334 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T23:06:43.335Z,1507331203.335 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:06:43.757Z,1507331203.757 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:06:44.489Z,1507331204.489 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:06:45.251Z,1507331205.251 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:06:45.470Z,1507331205.470 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US5CA83M.000
2017-10-06T23:06:45.659Z,1507331205.659 [NavChartDb](INFO): # of records loaded: 19732
2017-10-06T23:06:45.697Z,1507331205.697 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US5CA83M.000
2017-10-06T23:06:45.698Z,1507331205.698 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA62M.000
2017-10-06T23:06:46.088Z,1507331206.088 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:06:47.658Z,1507331207.658 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:06:48.860Z,1507331208.860 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:06:49.667Z,1507331209.667 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:06:50.463Z,1507331210.463 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:06:51.281Z,1507331211.281 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:06:52.485Z,1507331212.485 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:06:53.139Z,1507331213.139 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA62M.000
2017-10-06T23:06:53.268Z,1507331213.268 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:06:54.053Z,1507331214.053 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.392700 ug/l
2017-10-06T23:06:55.687Z,1507331215.687 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 34.141103 ug/l
2017-10-06T23:07:07.295Z,1507331227.295 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.476000 ug/l
2017-10-06T23:07:08.111Z,1507331228.111 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:07:08.872Z,1507331228.872 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:07:08.872Z,1507331228.872 [BPC1] No Fault, FailCount= 10
2017-10-06T23:07:09.687Z,1507331229.687 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.392700 ug/l
2017-10-06T23:07:10.895Z,1507331230.895 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:07:11.666Z,1507331231.666 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:07:12.460Z,1507331232.460 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.416500 ug/l
2017-10-06T23:07:14.121Z,1507331234.121 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.404600 ug/l
2017-10-06T23:07:15.283Z,1507331235.283 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:07:16.116Z,1507331236.116 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:07:16.869Z,1507331236.869 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:07:18.513Z,1507331238.513 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:07:19.317Z,1507331239.317 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:07:20.513Z,1507331240.513 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:07:21.284Z,1507331241.284 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:07:22.091Z,1507331242.091 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:07:22.913Z,1507331242.913 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:07:23.693Z,1507331243.693 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:07:24.401Z,1507331244.401 [BPC1](FAULT): Failed to initialize
2017-10-06T23:07:24.401Z,1507331244.401 [BPC1] Communications Fault, FailCount= 1
2017-10-06T23:07:24.402Z,1507331244.402 [BPC1](ERROR): Communications Fault
2017-10-06T23:07:24.506Z,1507331244.506 [CTD_NeilBrown](ERROR): serial buffer full
2017-10-06T23:07:24.506Z,1507331244.506 [CTD_NeilBrown] Communications Fault, FailCount= 1
2017-10-06T23:07:24.507Z,1507331244.507 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-06T23:07:24.508Z,1507331244.508 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-06T23:07:24.563Z,1507331244.563 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:07:24.563Z,1507331244.563 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-06T23:07:24.874Z,1507331244.874 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:07:24.887Z,1507331244.887 [Aanderaa_O2] No Fault, FailCount= 3
2017-10-06T23:07:24.890Z,1507331244.890 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:07:24.911Z,1507331244.911 [CTD_NeilBrown](INFO): Powering down
2017-10-06T23:07:25.684Z,1507331245.684 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:07:25.684Z,1507331245.684 [BPC1] No Fault, FailCount= 1
2017-10-06T23:07:26.182Z,1507331246.182 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-06T23:07:26.182Z,1507331246.182 [CTD_NeilBrown] No Fault, FailCount= 1
2017-10-06T23:07:26.477Z,1507331246.477 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:07:26.527Z,1507331246.527 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T23:07:26.528Z,1507331246.528 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:07:26.805Z,1507331246.805 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:07:26.805Z,1507331246.805 [Aanderaa_O2] Data Fault, FailCount= 1
2017-10-06T23:07:26.806Z,1507331246.806 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:07:26.935Z,1507331246.935 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:07:27.334Z,1507331247.334 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:07:27.446Z,1507331247.446 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:07:28.098Z,1507331248.098 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:07:28.099Z,1507331248.099 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-06T23:07:28.104Z,1507331248.104 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.404600 ug/l
2017-10-06T23:07:29.287Z,1507331249.287 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.464100 ug/l
2017-10-06T23:07:29.000Z,1507331250.000 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:07:29.000Z,1507331250.000 [Aanderaa_O2] Data Fault, FailCount= 2
2017-10-06T23:07:30.000Z,1507331250.000 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:07:30.026Z,1507331250.026 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:07:30.523Z,1507331250.523 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:07:30.676Z,1507331250.676 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.606900 ug/l
2017-10-06T23:07:31.297Z,1507331251.297 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:07:31.297Z,1507331251.297 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-06T23:07:31.740Z,1507331251.740 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 7.473200 ug/l
2017-10-06T23:07:38.382Z,1507331258.382 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2017-10-06T23:07:38.382Z,1507331258.382 [Rowe_600LCM] Communications Fault, FailCount= 4
2017-10-06T23:07:38.382Z,1507331258.382 [Rowe_600LCM](ERROR): Communications Fault
2017-10-06T23:07:38.786Z,1507331258.786 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2017-10-06T23:07:38.997Z,1507331258.997 [Rowe_600LCM](INFO): Powering down
2017-10-06T23:07:39.573Z,1507331259.573 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:07:39.574Z,1507331259.574 [Aanderaa_O2] Data Fault, FailCount= 3
2017-10-06T23:07:39.574Z,1507331259.574 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:07:39.613Z,1507331259.613 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.1 s old, using for 20.0 s.
2017-10-06T23:07:39.663Z,1507331259.663 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2017-10-06T23:07:39.664Z,1507331259.664 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:07:39.664Z,1507331259.664 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2017-10-06T23:07:39.887Z,1507331259.887 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:07:39.923Z,1507331259.923 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.5 s old, using for 20.0 s.
2017-10-06T23:07:40.174Z,1507331260.174 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.7 s old, using for 20.0 s.
2017-10-06T23:07:40.214Z,1507331260.214 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2017-10-06T23:07:40.214Z,1507331260.214 [Rowe_600LCM] No Fault, FailCount= 4
2017-10-06T23:07:40.571Z,1507331260.571 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.1 s old, using for 20.0 s.
2017-10-06T23:07:40.614Z,1507331260.614 [Rowe_600LCM](INFO): Initializing
2017-10-06T23:07:40.615Z,1507331260.615 [Rowe_600LCM](INFO): Checking LCM
2017-10-06T23:07:40.615Z,1507331260.615 [Rowe_600LCM](INFO): LCM OK
2017-10-06T23:07:40.615Z,1507331260.615 [Rowe_600LCM](INFO): Powering up
2017-10-06T23:07:40.946Z,1507331260.946 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.5 s old, using for 20.0 s.
2017-10-06T23:07:41.304Z,1507331261.304 [BPC1](FAULT): Failed to initialize
2017-10-06T23:07:41.304Z,1507331261.304 [BPC1] Communications Fault, FailCount= 2
2017-10-06T23:07:41.305Z,1507331261.305 [BPC1](ERROR): Communications Fault
2017-10-06T23:07:41.381Z,1507331261.381 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.9 s old, using for 20.0 s.
2017-10-06T23:07:41.427Z,1507331261.427 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:07:41.757Z,1507331261.757 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.3 s old, using for 20.0 s.
2017-10-06T23:07:42.174Z,1507331262.174 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.7 s old, using for 20.0 s.
2017-10-06T23:07:42.552Z,1507331262.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.1 s old, using for 20.0 s.
2017-10-06T23:07:42.624Z,1507331262.624 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:07:42.624Z,1507331262.624 [BPC1] No Fault, FailCount= 2
2017-10-06T23:07:43.029Z,1507331263.029 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.6 s old, using for 20.0 s.
2017-10-06T23:07:43.348Z,1507331263.348 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.9 s old, using for 20.0 s.
2017-10-06T23:07:43.751Z,1507331263.751 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.3 s old, using for 20.0 s.
2017-10-06T23:07:44.160Z,1507331264.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.7 s old, using for 20.0 s.
2017-10-06T23:07:44.562Z,1507331264.562 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.1 s old, using for 20.0 s.
2017-10-06T23:07:44.925Z,1507331264.925 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2017-10-06T23:07:45.041Z,1507331265.041 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.6 s old, using for 20.0 s.
2017-10-06T23:07:45.109Z,1507331265.109 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 38400 >& /dev/null &
2017-10-06T23:07:45.110Z,1507331265.110 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2017-10-06T23:07:45.111Z,1507331265.111 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2017-10-06T23:07:45.112Z,1507331265.112 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2017-10-06T23:07:45.395Z,1507331265.395 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.9 s old, using for 20.0 s.
2017-10-06T23:07:56.815Z,1507331276.815 [CommandLine](IMPORTANT): got command show stack
2017-10-06T23:07:56.815Z,1507331276.815 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-06T23:07:56.816Z,1507331276.816 [Science](IMPORTANT): Priority 0: Science:A
2017-10-06T23:07:56.817Z,1507331276.817 [Science](IMPORTANT): Priority 1: Science:C
2017-10-06T23:07:56.817Z,1507331276.817 [Science](IMPORTANT): Priority 2: Science:F
2017-10-06T23:07:58.125Z,1507331278.125 [BPC1](FAULT): Failed to initialize
2017-10-06T23:07:58.125Z,1507331278.125 [BPC1] Communications Fault, FailCount= 3
2017-10-06T23:07:58.125Z,1507331278.125 [BPC1](ERROR): Communications Fault
2017-10-06T23:07:58.257Z,1507331278.257 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:07:59.390Z,1507331279.390 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:07:59.390Z,1507331279.390 [BPC1] No Fault, FailCount= 3
2017-10-06T23:08:02.605Z,1507331282.605 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 30.951902 ug/l
2017-10-06T23:08:03.341Z,1507331283.341 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:08:04.733Z,1507331284.733 [CTD_NeilBrown](ERROR): serial buffer full
2017-10-06T23:08:04.734Z,1507331284.734 [CTD_NeilBrown] Communications Fault, FailCount= 2
2017-10-06T23:08:04.734Z,1507331284.734 [CTD_NeilBrown](ERROR): Communications Fault
2017-10-06T23:08:04.736Z,1507331284.736 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2017-10-06T23:08:04.993Z,1507331284.993 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2017-10-06T23:08:05.002Z,1507331285.002 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:05.144Z,1507331285.144 [CTD_NeilBrown](INFO): Powering down
2017-10-06T23:08:06.224Z,1507331286.224 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:08:06.626Z,1507331286.626 [CBIT](INFO): Clearing failed state for component CTD_NeilBrown
2017-10-06T23:08:06.626Z,1507331286.626 [CTD_NeilBrown] No Fault, FailCount= 2
2017-10-06T23:08:06.760Z,1507331286.760 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2017-10-06T23:08:06.761Z,1507331286.761 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:08:07.019Z,1507331287.019 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:08:08.227Z,1507331288.227 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:08:09.428Z,1507331289.428 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:08:09.819Z,1507331289.819 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:11.391Z,1507331291.391 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:12.202Z,1507331292.202 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:08:12.973Z,1507331292.973 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:14.908Z,1507331294.908 [BPC1](FAULT): Failed to initialize
2017-10-06T23:08:14.908Z,1507331294.908 [BPC1] Communications Fault, FailCount= 4
2017-10-06T23:08:14.908Z,1507331294.908 [BPC1](ERROR): Communications Fault
2017-10-06T23:08:15.044Z,1507331295.044 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:08:15.818Z,1507331295.818 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:08:16.218Z,1507331296.218 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:08:16.218Z,1507331296.218 [BPC1] No Fault, FailCount= 4
2017-10-06T23:08:16.650Z,1507331296.650 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:08:17.435Z,1507331297.435 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:19.021Z,1507331299.021 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:19.937Z,1507331299.937 [NavChartDb](INFO): # of records loaded: 5000
2017-10-06T23:08:20.224Z,1507331300.224 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:08:21.004Z,1507331301.004 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:21.820Z,1507331301.820 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:08:22.944Z,1507331302.944 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:08:22.944Z,1507331302.944 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2017-10-06T23:08:22.945Z,1507331302.945 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2017-10-06T23:08:22.949Z,1507331302.949 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:08:22.949Z,1507331302.949 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2017-10-06T23:08:22.949Z,1507331302.949 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2017-10-06T23:08:23.022Z,1507331303.022 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2017-10-06T23:08:23.023Z,1507331303.023 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2017-10-06T23:08:23.437Z,1507331303.437 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2017-10-06T23:08:23.437Z,1507331303.437 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2017-10-06T23:08:23.437Z,1507331303.437 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2017-10-06T23:08:23.437Z,1507331303.437 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2017-10-06T23:08:23.461Z,1507331303.461 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:08:23.731Z,1507331303.731 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-06T23:08:23.732Z,1507331303.732 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:08:23.732Z,1507331303.732 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:08:23.732Z,1507331303.732 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-06T23:08:23.733Z,1507331303.733 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:08:23.733Z,1507331303.733 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:08:24.020Z,1507331304.020 [CTD_NeilBrown](ERROR): Salinity reading out of range: 1500.000000 psu
2017-10-06T23:08:24.121Z,1507331304.121 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-10-06T23:08:24.191Z,1507331304.191 [CTD_NeilBrown](ERROR): Bad response: $PRTI02
2017-10-06T23:08:24.304Z,1507331304.304 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:08:25.404Z,1507331305.404 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:26.202Z,1507331306.202 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:08:28.008Z,1507331308.008 [CTD_NeilBrown](ERROR): Salinity reading out of range: 15.433000 psu
2017-10-06T23:08:28.056Z,1507331308.056 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-10-06T23:08:28.057Z,1507331308.057 [CTD_NeilBrown](INFO): Failure count cleared after critical for CTD_NeilBrown
2017-10-06T23:08:28.988Z,1507331308.988 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:29.803Z,1507331309.803 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:08:30.611Z,1507331310.611 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:08:31.713Z,1507331311.713 [BPC1](FAULT): Failed to initialize
2017-10-06T23:08:31.713Z,1507331311.713 [BPC1] Communications Fault, FailCount= 5
2017-10-06T23:08:31.713Z,1507331311.713 [BPC1](ERROR): Communications Fault
2017-10-06T23:08:31.827Z,1507331311.827 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:08:32.249Z,1507331312.249 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:08:39.773Z,1507331319.773 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:08:39.773Z,1507331319.773 [BPC1] No Fault, FailCount= 5
2017-10-06T23:08:39.796Z,1507331319.796 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:40.170Z,1507331320.170 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:08:41.121Z,1507331321.121 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:08:42.764Z,1507331322.764 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 24.145100 ug/l
2017-10-06T23:08:55.039Z,1507331335.039 [BPC1](FAULT): Failed to initialize
2017-10-06T23:08:55.039Z,1507331335.039 [BPC1] Communications Fault, FailCount= 6
2017-10-06T23:08:55.039Z,1507331335.039 [BPC1](ERROR): Communications Fault
2017-10-06T23:08:55.166Z,1507331335.166 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:08:56.326Z,1507331336.326 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:08:56.335Z,1507331336.335 [BPC1] No Fault, FailCount= 6
2017-10-06T23:09:11.863Z,1507331351.863 [BPC1](FAULT): Failed to initialize
2017-10-06T23:09:11.863Z,1507331351.863 [BPC1] Communications Fault, FailCount= 7
2017-10-06T23:09:11.863Z,1507331351.863 [BPC1](ERROR): Communications Fault
2017-10-06T23:09:11.898Z,1507331351.898 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:09:13.159Z,1507331353.159 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:09:13.159Z,1507331353.159 [BPC1] No Fault, FailCount= 7
2017-10-06T23:09:20.338Z,1507331360.338 [CBIT](DEBUG): EFC running - data check-sum false
2017-10-06T23:09:28.642Z,1507331368.642 [BPC1](FAULT): Failed to initialize
2017-10-06T23:09:28.642Z,1507331368.642 [BPC1] Communications Fault, FailCount= 8
2017-10-06T23:09:28.642Z,1507331368.642 [BPC1](ERROR): Communications Fault
2017-10-06T23:09:28.727Z,1507331368.727 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:09:29.967Z,1507331369.967 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:09:29.968Z,1507331369.968 [BPC1] No Fault, FailCount= 8
2017-10-06T23:09:31.176Z,1507331371.176 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 23.645300 ug/l
2017-10-06T23:09:31.994Z,1507331371.994 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:39.658Z,1507331379.658 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:09:39.885Z,1507331379.885 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:40.263Z,1507331380.263 [CTD_NeilBrown](ERROR): Salinity reading out of range: 15.433000 psu
2017-10-06T23:09:40.275Z,1507331380.275 [CTD_NeilBrown](INFO): some bad data, not updating bins
2017-10-06T23:09:40.934Z,1507331380.934 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:41.386Z,1507331381.386 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2017-10-06T23:09:41.386Z,1507331381.386 [Rowe_600LCM] Communications Fault, FailCount= 5
2017-10-06T23:09:41.386Z,1507331381.386 [Rowe_600LCM](ERROR): Communications Fault
2017-10-06T23:09:41.732Z,1507331381.732 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.4 s old, using for 20.0 s.
2017-10-06T23:09:41.747Z,1507331381.747 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2017-10-06T23:09:41.747Z,1507331381.747 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2017-10-06T23:09:41.749Z,1507331381.749 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:41.790Z,1507331381.790 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2017-10-06T23:09:42.004Z,1507331382.004 [Rowe_600LCM](INFO): Powering down
2017-10-06T23:09:42.165Z,1507331382.165 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 0.8 s old, using for 20.0 s.
2017-10-06T23:09:42.541Z,1507331382.541 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2017-10-06T23:09:42.600Z,1507331382.600 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:09:42.785Z,1507331382.785 [NavChartDb](INFO): # of records loaded: 10000
2017-10-06T23:09:42.939Z,1507331382.939 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2017-10-06T23:09:43.344Z,1507331383.344 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2017-10-06T23:09:43.400Z,1507331383.400 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:43.741Z,1507331383.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2017-10-06T23:09:44.209Z,1507331384.209 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.9 s old, using for 20.0 s.
2017-10-06T23:09:44.249Z,1507331384.249 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:44.553Z,1507331384.553 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2017-10-06T23:09:44.966Z,1507331384.966 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2017-10-06T23:09:45.091Z,1507331385.091 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:45.365Z,1507331385.365 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2017-10-06T23:09:45.712Z,1507331385.712 [BPC1](FAULT): Failed to initialize
2017-10-06T23:09:45.712Z,1507331385.712 [BPC1] Communications Fault, FailCount= 9
2017-10-06T23:09:45.712Z,1507331385.712 [BPC1](ERROR): Communications Fault
2017-10-06T23:09:45.793Z,1507331385.793 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.5 s old, using for 20.0 s.
2017-10-06T23:09:45.843Z,1507331385.843 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:09:46.146Z,1507331386.146 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2017-10-06T23:09:46.225Z,1507331386.225 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:46.549Z,1507331386.549 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2017-10-06T23:09:46.950Z,1507331386.950 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2017-10-06T23:09:47.019Z,1507331387.019 [CBIT](INFO): Clearing failed state for component BPC1
2017-10-06T23:09:47.019Z,1507331387.019 [BPC1] No Fault, FailCount= 9
2017-10-06T23:09:47.051Z,1507331387.051 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:47.419Z,1507331387.419 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.1 s old, using for 20.0 s.
2017-10-06T23:09:47.735Z,1507331387.735 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2017-10-06T23:09:47.800Z,1507331387.800 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:09:48.141Z,1507331388.141 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2017-10-06T23:09:48.584Z,1507331388.584 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.3 s old, using for 20.0 s.
2017-10-06T23:09:48.638Z,1507331388.638 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:48.929Z,1507331388.929 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2017-10-06T23:09:49.349Z,1507331389.349 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2017-10-06T23:09:49.472Z,1507331389.472 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:49.757Z,1507331389.757 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2017-10-06T23:09:50.153Z,1507331390.153 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2017-10-06T23:09:50.556Z,1507331390.556 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2017-10-06T23:09:50.611Z,1507331390.611 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:50.941Z,1507331390.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.6 s old, using for 20.0 s.
2017-10-06T23:09:51.341Z,1507331391.341 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.0 s old, using for 20.0 s.
2017-10-06T23:09:51.396Z,1507331391.396 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:51.744Z,1507331391.744 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.4 s old, using for 20.0 s.
2017-10-06T23:09:52.128Z,1507331392.128 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 10.8 s old, using for 20.0 s.
2017-10-06T23:09:52.203Z,1507331392.203 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:09:52.541Z,1507331392.541 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.2 s old, using for 20.0 s.
2017-10-06T23:09:52.944Z,1507331392.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 11.6 s old, using for 20.0 s.
2017-10-06T23:09:52.996Z,1507331392.996 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:09:53.353Z,1507331393.353 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.0 s old, using for 20.0 s.
2017-10-06T23:09:53.742Z,1507331393.742 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.4 s old, using for 20.0 s.
2017-10-06T23:09:53.808Z,1507331393.808 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:54.144Z,1507331394.144 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 12.8 s old, using for 20.0 s.
2017-10-06T23:09:54.524Z,1507331394.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.2 s old, using for 20.0 s.
2017-10-06T23:09:54.951Z,1507331394.951 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 13.6 s old, using for 20.0 s.
2017-10-06T23:09:55.008Z,1507331395.008 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:09:55.362Z,1507331395.362 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.0 s old, using for 20.0 s.
2017-10-06T23:09:55.740Z,1507331395.740 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.4 s old, using for 20.0 s.
2017-10-06T23:09:55.832Z,1507331395.832 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:56.147Z,1507331396.147 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 14.8 s old, using for 20.0 s.
2017-10-06T23:09:56.552Z,1507331396.552 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.2 s old, using for 20.0 s.
2017-10-06T23:09:56.604Z,1507331396.604 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:09:56.940Z,1507331396.940 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.6 s old, using for 20.0 s.
2017-10-06T23:09:57.323Z,1507331397.323 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.0 s old, using for 20.0 s.
2017-10-06T23:09:57.409Z,1507331397.409 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:09:57.741Z,1507331397.741 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.4 s old, using for 20.0 s.
2017-10-06T23:09:58.137Z,1507331398.137 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.8 s old, using for 20.0 s.
2017-10-06T23:09:58.226Z,1507331398.226 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:09:58.535Z,1507331398.535 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.2 s old, using for 20.0 s.
2017-10-06T23:09:58.941Z,1507331398.941 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.6 s old, using for 20.0 s.
2017-10-06T23:09:59.356Z,1507331399.356 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.0 s old, using for 20.0 s.
2017-10-06T23:09:59.432Z,1507331399.432 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.333200 ug/l
2017-10-06T23:09:59.752Z,1507331399.752 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.4 s old, using for 20.0 s.
2017-10-06T23:10:00.133Z,1507331400.133 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.8 s old, using for 20.0 s.
2017-10-06T23:10:00.194Z,1507331400.194 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:10:00.563Z,1507331400.563 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.2 s old, using for 20.0 s.
2017-10-06T23:10:00.928Z,1507331400.928 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.6 s old, using for 20.0 s.
2017-10-06T23:10:00.983Z,1507331400.983 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.380800 ug/l
2017-10-06T23:10:01.820Z,1507331401.820 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:10:02.504Z,1507331402.504 [BPC1](FAULT): Failed to initialize
2017-10-06T23:10:02.504Z,1507331402.504 [BPC1] Communications Fault, FailCount= 10
2017-10-06T23:10:02.504Z,1507331402.504 [BPC1](ERROR): Communications Fault
2017-10-06T23:10:02.615Z,1507331402.615 [CBIT](ERROR): Communications Fault in component: BPC1
2017-10-06T23:10:02.615Z,1507331402.615 [CBIT](CRITICAL): Communications Fault in component: BPC1
2017-10-06T23:10:02.617Z,1507331402.617 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:10:02.969Z,1507331402.969 [CBIT](INFO): Critical error at 20171006T231002
2017-10-06T23:10:02.969Z,1507331402.969 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2017-10-06T23:10:03.345Z,1507331403.345 [MissionManager](INFO): MissionManager is completed.
2017-10-06T23:10:03.345Z,1507331403.345 [MissionManager](INFO): Uninitializing Mission Science
2017-10-06T23:10:03.345Z,1507331403.345 [Science] Stopped
2017-10-06T23:10:03.345Z,1507331403.345 [Science](DEBUG): Aggregate::uninitialize Science
2017-10-06T23:10:03.345Z,1507331403.345 [Science:A] Stopped
2017-10-06T23:10:03.345Z,1507331403.345 [Science:C] Stopped
2017-10-06T23:10:03.346Z,1507331403.346 [Science:F] Stopped
2017-10-06T23:10:03.574Z,1507331403.574 [WetLabsBB2FL](INFO): Powering down
2017-10-06T23:10:03.764Z,1507331403.764 [MissionManager](IMPORTANT): Started mission Default
2017-10-06T23:10:03.764Z,1507331403.764 [Default] Running Loop=1
2017-10-06T23:10:03.764Z,1507331403.764 [Default](DEBUG): Aggregate::initialize Default
2017-10-06T23:10:03.764Z,1507331403.764 [Default:B.GoToSurface] Running Loop=1
2017-10-06T23:10:03.764Z,1507331403.764 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-10-06T23:10:03.764Z,1507331403.764 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-10-06T23:10:03.765Z,1507331403.765 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-10-06T23:10:03.767Z,1507331403.767 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-10-06T23:10:03.767Z,1507331403.767 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-10-06T23:10:03.768Z,1507331403.768 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-10-06T23:10:03.768Z,1507331403.768 [Default:A.Wait] Running Loop=1
2017-10-06T23:10:03.768Z,1507331403.768 [Default:A.Wait](DEBUG): Initialize Wait Component.
2017-10-06T23:10:03.804Z,1507331403.804 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water nan ug/l
2017-10-06T23:10:09.796Z,1507331409.796 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:10:09.796Z,1507331409.796 [Aanderaa_O2] No Fault, FailCount= 3
2017-10-06T23:10:11.700Z,1507331411.700 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:10:11.700Z,1507331411.700 [Aanderaa_O2] Data Fault, FailCount= 1
2017-10-06T23:10:11.700Z,1507331411.700 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:10:11.780Z,1507331411.780 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:10:12.227Z,1507331412.227 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:10:12.998Z,1507331412.998 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:10:12.998Z,1507331412.998 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-06T23:10:14.911Z,1507331414.911 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:10:14.911Z,1507331414.911 [Aanderaa_O2] Data Fault, FailCount= 2
2017-10-06T23:10:14.911Z,1507331414.911 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:10:14.997Z,1507331414.997 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:10:15.419Z,1507331415.419 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:10:16.176Z,1507331416.176 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:10:16.176Z,1507331416.176 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-06T23:10:16.934Z,1507331416.934 [Default:A.Wait](INFO): Done Waiting.
2017-10-06T23:10:16.936Z,1507331416.936 [Default:A.Wait] Stopped
2017-10-06T23:10:16.936Z,1507331416.936 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2017-10-06T23:10:17.375Z,1507331417.375 [Default:CheckIn] Running Loop=1
2017-10-06T23:10:17.375Z,1507331417.375 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-10-06T23:10:17.376Z,1507331417.376 [Default:CheckIn:Read_GPS] Running Loop=1
2017-10-06T23:10:18.105Z,1507331418.105 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:10:18.105Z,1507331418.105 [Aanderaa_O2] Data Fault, FailCount= 3
2017-10-06T23:10:18.105Z,1507331418.105 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:10:18.200Z,1507331418.200 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:10:18.200Z,1507331418.200 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2017-10-06T23:10:18.635Z,1507331418.635 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:10:19.405Z,1507331419.405 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:10:19.405Z,1507331419.405 [MassServo] No Fault, FailCount= 5
2017-10-06T23:10:23.015Z,1507331423.015 [MassServo](FAULT): Overload Error
2017-10-06T23:10:23.015Z,1507331423.015 [MassServo] Hardware Fault, FailCount= 1
2017-10-06T23:10:23.015Z,1507331423.015 [MassServo](ERROR): Hardware Fault
2017-10-06T23:10:23.025Z,1507331423.025 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:10:23.345Z,1507331423.345 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:10:23.345Z,1507331423.345 [MassServo](INFO): Powering down
2017-10-06T23:10:24.170Z,1507331424.170 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:10:24.295Z,1507331424.295 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:10:24.305Z,1507331424.305 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:10:24.305Z,1507331424.305 [MassServo] No Fault, FailCount= 1
2017-10-06T23:10:26.819Z,1507331426.819 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2017-10-06T23:10:26.819Z,1507331426.819 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2017-10-06T23:10:27.176Z,1507331427.176 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2017-10-06T23:10:27.180Z,1507331427.180 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2017-10-06T23:10:27.182Z,1507331427.182 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2017-10-06T23:10:27.184Z,1507331427.184 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2017-10-06T23:10:27.189Z,1507331427.189 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2017-10-06T23:10:27.194Z,1507331427.194 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2017-10-06T23:10:27.199Z,1507331427.199 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2017-10-06T23:10:27.202Z,1507331427.202 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2017-10-06T23:10:27.204Z,1507331427.204 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2017-10-06T23:10:27.206Z,1507331427.206 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2017-10-06T23:10:27.315Z,1507331427.315 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 1.000000 bool
2017-10-06T23:10:27.318Z,1507331427.318 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 bool
2017-10-06T23:10:27.356Z,1507331427.356 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 0.000000 bool
2017-10-06T23:10:27.380Z,1507331427.380 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2017-10-06T23:10:27.416Z,1507331427.416 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2017-10-06T23:10:27.419Z,1507331427.419 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2017-10-06T23:10:27.428Z,1507331427.428 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2017-10-06T23:10:27.481Z,1507331427.481 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2017-10-06T23:10:27.518Z,1507331427.518 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2017-10-06T23:10:27.521Z,1507331427.521 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2017-10-06T23:10:27.543Z,1507331427.543 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2017-10-06T23:10:27.567Z,1507331427.567 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2017-10-06T23:10:27.574Z,1507331427.574 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2017-10-06T23:10:27.597Z,1507331427.597 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2017-10-06T23:10:27.605Z,1507331427.605 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2017-10-06T23:10:27.621Z,1507331427.621 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2017-10-06T23:10:27.632Z,1507331427.632 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2017-10-06T23:10:27.640Z,1507331427.640 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2017-10-06T23:10:27.643Z,1507331427.643 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2017-10-06T23:10:27.645Z,1507331427.645 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2017-10-06T23:10:27.653Z,1507331427.653 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2017-10-06T23:10:27.709Z,1507331427.709 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan arcdeg
2017-10-06T23:10:27.766Z,1507331427.766 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-10-06T23:10:27.826Z,1507331427.826 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2017-10-06T23:10:27.886Z,1507331427.886 [MassServo](FAULT): Overload Error
2017-10-06T23:10:27.887Z,1507331427.887 [MassServo] Hardware Fault, FailCount= 2
2017-10-06T23:10:27.887Z,1507331427.887 [MassServo](ERROR): Hardware Fault
2017-10-06T23:10:27.892Z,1507331427.892 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:10:27.924Z,1507331427.924 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2017-10-06T23:10:28.008Z,1507331428.008 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Aggregate xmlns="Tethys"
       xmlns:Derivation="Tethys/Derivation"
       xmlns:Science="Tethys/Science"
       xmlns:Sensor="Tethys/Sensor"
       xmlns:Trigger="Tethys/Trigger"
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Derivation http://okeanids.mbari.org/tethys/Xml/Derivation.xsd
                           Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                           Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Science">

    <DefineArg Name="SampleISUS"><Description>
        Set either this or PeakDetectNO3Active to True in order to sample
        Nitrate. EnabledISUS must also be true.
    </Description><False/></DefineArg>

    <DefineArg Name="SampleISUSmaxPitch"><Description>
        Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>60.0</Value></DefineArg>

    <DefineArg Name="SampleISUSminPitch"><Description>
        Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>-60.0</Value></DefineArg>

    <DefineArg Name="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="HighestChlPeakReportActive"><Description>
        Turns on reporting of the highest peak value on yo-yo profiles in a
        horizontal sliding window (of length numProfilesSlidingwindow)
    </Description><False/></DefineArg>

    <DefineArg Name="PatchTracking"><Description>
        If tracking a patch
    </Description><False/></DefineArg>

    <DefineArg Name="FilterWidthHorizontal"><Description>
        Width of boxcar filter applied to yoyo-wise chl peaks to pick out the
        highest peak.
    </Description><Units:count/><Value>3</Value></DefineArg>

    <DefineArg Name="NumProfilesSlidingwindow"><Description>
        Length of horizontal sliding window. The highest yoyo-wise chl peak
        (after low-pass filtering by a filter of length FilterWidthHorizontal)
        within this window.
    </Description><Units:count/><Value>100</Value></DefineArg>

    <DefineArg Name="PeakDetectNO3Active"><Description>
        Turns on peak detection of Nitrate (and turns on ISUS).
    </Description><False/></DefineArg>

    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

    <DefineArg Name="EnabledAanderaaO2"><Description>
        Automatically set to True if the Aanderaa O2 sensor is installed. Set to
        false to disable reading Aandera O2.
    </Description><Science:Aanderaa_O2.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledNeilBrown"><Description>
        Automatically set to true if the Neil Brown CTD is enabled. Set to false
        to disable reading from the Neil Brown.
    </Description><Science:CTD_NeilBrown.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledSeabird"><Description>
        Automatically set to true if the CTD is enabled. Set to false to disable
        reading from the CTD.
    </Description><Science:CTD_Seabird.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledTurbulence_NPS"><Description>
        Automatically set to true if the NPS Turbulence sensor is enabled. Set
        to false to disable reading from the NPS Turbulence sensor.
    </Description><Science:Turbulence_NPS.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsBB2FL"><Description>
        Automatically set to true if the the WetLabs BB2FL is enabled. Set to
        false to disable the WetLabs BB2FL.
    </Description><Science:WetLabsBB2FL.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledISUS"><Description>
        Automatically set to True if ISUS is enabled. Set to false to disable
        ISUS.
    </Description><Science:ISUS.loadAtStartup/></DefineArg>

<!--
    <DefineArg Name="EnabledSeeStar"><Description>
        Automatically set to True if SeeStar/SCPI is enabled. Set false to
        override.
    </Description><Sensor:SCPI.loadAtStartup/></DefineArg>

    <DefineArg Name="SeeStarTimeout"><Description>
        Timeout to trigger/read trigger for SeeStar camera.
    </Description><Sensor:SCPI.sampleTime/></DefineArg>

    <DefineArg Name="SeeStarTriggerDepth"><Description>
        Trigger the camera above this depth.
    </Description><Units:meter/><Value>40.0</Value></DefineArg>
-->

    <DefineArg Name="LowPassWindowLength"><Description>
        Low-pass window length (based on depth sensor sampling interval 0.4
        second) for low-pass filtering.
    </Description><Units:count/><Value>20</Value></DefineArg>

    <DefineArg Name="PeakChlShallowBound"><Description>
        Shallow depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineArg Name="PeakChlDeepBound"><Description>
        Deep depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineOutput Name="PeakChl"><Units:microgram_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3"><Units:micromole_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Depth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Latitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Longitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChl"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlDistance"><Units:degree/><Value>NaN</Value></DefineOutput>

    <Parallel/>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledAanderaaO2"/>
        </While>
        <Universal:mass_concentration_of_oxygen_in_sea_water/>
    </ReadData>

    <ReadData>
        <While>
            <Arg Name="EnabledISUS"/>
            <And><Universal:platform_pitch_angle/><Lt><Arg Name="SampleISUSmaxPitch"/></Lt><And><Universal:platform_pitch_angle/><Gt><Arg Name="SampleISUSminPitch"/></Gt><And><Arg Name="SampleISUS"/><Or><Arg Name="PeakDetectNO3Active"/></Or></And></And></And>
        </While>
        <Universal:mole_concentration_of_nitrate_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
        </While>
        <Universal:sea_water_temperature/>
        <Universal:sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
            <And><Arg Name="UpwardDerivativeOfTemperatureActive"/></And>
        </While>
        <Universal:upward_derivative_of_sea_water_temperature/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledTurbulence_NPS"/>
        </While>
        <Science:Turbulence_NPS.MicroCond/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate  Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_chlorophyll_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakChl"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakChlDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakChl"/><Arg Name="PeakChlDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

        <While>
            <Arg Name="HighestChlPeakReportActive"/>
        </While>

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakChl"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakChlDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakChlLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakChlLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <OutputArg Name="PatchChl"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchChlDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchChlLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchChlLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchChlDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

        <While>
            <Arg Name="PeakDetectNO3Active"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakNO3"/><Arg Name="PeakNO3Depth"/>
        </SendData>

    </Aggregate>

<!--
    <Aggregate Id="RollSeeStar">

        <Description>
            Turn on the SeeStar/SCPI camera.
        </Description>

        <When>
            <Arg Name="EnabledSeeStar"/>
            <And><Universal:depth/><Lt><Arg Name="SeeStarTriggerDepth"/></Lt></And>
        </When>

        <ReadDatum Id="TriggerSeeStar">
            <Timeout Duration="SeeStarTimeout"/>
            <Sensor:SCPI.sampleSCPI/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Arg Name="SeeStarTimeout"/></Setting>
        </Guidance:Wait>

    </Aggregate>
-->

</Aggregate>


2017-10-06T23:10:28.066Z,1507331428.066 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2017-10-06T23:10:28.174Z,1507331428.174 [Default] Stopped
2017-10-06T23:10:28.174Z,1507331428.174 [Default](DEBUG): Aggregate::uninitialize Default
2017-10-06T23:10:28.174Z,1507331428.174 [Default:B.GoToSurface] Stopped
2017-10-06T23:10:28.174Z,1507331428.174 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2017-10-06T23:10:28.174Z,1507331428.174 [Default:CheckIn] Stopped
2017-10-06T23:10:28.174Z,1507331428.174 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2017-10-06T23:10:28.174Z,1507331428.174 [Default:CheckIn:Read_GPS] Stopped
2017-10-06T23:10:28.175Z,1507331428.175 [MissionManager](IMPORTANT): Started mission Science
2017-10-06T23:10:28.175Z,1507331428.175 [Science] Running Loop=1
2017-10-06T23:10:28.175Z,1507331428.175 [Science](DEBUG): Aggregate::initialize Science
2017-10-06T23:10:28.175Z,1507331428.175 [Science:A] Running Loop=1
2017-10-06T23:10:28.175Z,1507331428.175 [Science:B] Running Loop=1
2017-10-06T23:10:28.175Z,1507331428.175 [Science:C] Running Loop=1
2017-10-06T23:10:28.175Z,1507331428.175 [Science:D] Running Loop=1
2017-10-06T23:10:28.175Z,1507331428.175 [Science:E] Running Loop=1
2017-10-06T23:10:28.175Z,1507331428.175 [Science:F] Running Loop=1
2017-10-06T23:10:28.176Z,1507331428.176 [Science:PeakDetectChl] Running Loop=1
2017-10-06T23:10:28.176Z,1507331428.176 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2017-10-06T23:10:28.176Z,1507331428.176 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2017-10-06T23:10:28.176Z,1507331428.176 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-10-06T23:10:28.178Z,1507331428.178 [Science:HighestChlPeakReport] Running Loop=1
2017-10-06T23:10:28.178Z,1507331428.178 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2017-10-06T23:10:28.178Z,1507331428.178 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2017-10-06T23:10:28.178Z,1507331428.178 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2017-10-06T23:10:28.184Z,1507331428.184 [Science:PeakDetectNO3] Running Loop=1
2017-10-06T23:10:28.184Z,1507331428.184 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2017-10-06T23:10:28.185Z,1507331428.185 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2017-10-06T23:10:28.185Z,1507331428.185 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2017-10-06T23:10:28.232Z,1507331428.232 [Science:PeakDetectNO3] Stopped
2017-10-06T23:10:28.232Z,1507331428.232 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2017-10-06T23:10:28.232Z,1507331428.232 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2017-10-06T23:10:28.232Z,1507331428.232 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-10-06T23:10:28.232Z,1507331428.232 [Science:HighestChlPeakReport] Stopped
2017-10-06T23:10:28.232Z,1507331428.232 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2017-10-06T23:10:28.232Z,1507331428.232 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2017-10-06T23:10:28.232Z,1507331428.232 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2017-10-06T23:10:28.233Z,1507331428.233 [Science:PeakDetectChl] Stopped
2017-10-06T23:10:28.233Z,1507331428.233 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2017-10-06T23:10:28.233Z,1507331428.233 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2017-10-06T23:10:28.233Z,1507331428.233 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2017-10-06T23:10:28.233Z,1507331428.233 [Science:F] Running Loop=1
2017-10-06T23:10:28.233Z,1507331428.233 [Science:F](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2017-10-06T23:10:28.240Z,1507331428.240 [Science:E] Stopped
2017-10-06T23:10:28.240Z,1507331428.240 [Science:D] Stopped
2017-10-06T23:10:28.240Z,1507331428.240 [Science:C] Running Loop=1
2017-10-06T23:10:28.241Z,1507331428.241 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2017-10-06T23:10:28.241Z,1507331428.241 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2017-10-06T23:10:28.247Z,1507331428.247 [Science:B] Stopped
2017-10-06T23:10:28.247Z,1507331428.247 [Science:A] Running Loop=1
2017-10-06T23:10:28.251Z,1507331428.251 [Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2017-10-06T23:10:28.274Z,1507331428.274 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:10:28.274Z,1507331428.274 [MassServo](INFO): Powering down
2017-10-06T23:10:28.637Z,1507331428.637 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=4
2017-10-06T23:10:28.637Z,1507331428.637 [WetLabsBB2FL](INFO): Powering up
2017-10-06T23:10:28.954Z,1507331428.954 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:10:29.075Z,1507331429.075 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:10:29.082Z,1507331429.082 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:10:29.082Z,1507331429.082 [MassServo] No Fault, FailCount= 2
2017-10-06T23:10:31.828Z,1507331431.828 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.321300 ug/l
2017-10-06T23:10:32.643Z,1507331432.643 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:10:32.994Z,1507331432.994 [MassServo](FAULT): Overload Error
2017-10-06T23:10:32.995Z,1507331432.995 [MassServo] Hardware Fault, FailCount= 3
2017-10-06T23:10:32.995Z,1507331432.995 [MassServo](ERROR): Hardware Fault
2017-10-06T23:10:33.008Z,1507331433.008 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:10:38.467Z,1507331438.467 [CommandLine](IMPORTANT): got command failComponent
2017-10-06T23:10:38.467Z,1507331438.467 [CommandLine](IMPORTANT): Failed components:
2017-10-06T23:10:38.467Z,1507331438.467 [CommandLine](IMPORTANT): DropWeight: Hardware Fault
2017-10-06T23:10:38.468Z,1507331438.468 [CommandLine](IMPORTANT): Rowe_600LCM: Communications Fault
2017-10-06T23:10:38.468Z,1507331438.468 [CommandLine](IMPORTANT): BPC1: Communications Fault
2017-10-06T23:10:38.468Z,1507331438.468 [CommandLine](IMPORTANT): Aanderaa_O2: Data Fault
2017-10-06T23:10:38.468Z,1507331438.468 [CommandLine](IMPORTANT): MassServo: Hardware Fault
2017-10-06T23:10:39.851Z,1507331439.851 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:10:39.851Z,1507331439.851 [MassServo](INFO): Powering down
2017-10-06T23:10:39.881Z,1507331439.881 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:10:40.453Z,1507331440.453 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:10:40.569Z,1507331440.569 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:10:40.587Z,1507331440.587 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:10:40.587Z,1507331440.587 [MassServo] No Fault, FailCount= 3
2017-10-06T23:10:40.589Z,1507331440.589 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.345100 ug/l
2017-10-06T23:10:41.222Z,1507331441.222 [CommandLine](IMPORTANT): got command show stack
2017-10-06T23:10:41.223Z,1507331441.223 [CommandLine](IMPORTANT): Behavior Stack:

2017-10-06T23:10:41.224Z,1507331441.224 [Science](IMPORTANT): Priority 0: Science:A
2017-10-06T23:10:41.224Z,1507331441.224 [Science](IMPORTANT): Priority 1: Science:C
2017-10-06T23:10:41.224Z,1507331441.224 [Science](IMPORTANT): Priority 2: Science:F
2017-10-06T23:10:41.673Z,1507331441.673 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.321300 ug/l
2017-10-06T23:10:42.456Z,1507331442.456 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:10:44.095Z,1507331444.095 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.392700 ug/l
2017-10-06T23:10:44.510Z,1507331444.510 [MassServo](FAULT): Overload Error
2017-10-06T23:10:44.511Z,1507331444.511 [MassServo] Hardware Fault, FailCount= 4
2017-10-06T23:10:44.511Z,1507331444.511 [MassServo](ERROR): Hardware Fault
2017-10-06T23:10:44.518Z,1507331444.518 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:10:44.816Z,1507331444.816 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:10:44.817Z,1507331444.817 [MassServo](INFO): Powering down
2017-10-06T23:10:45.280Z,1507331445.280 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.357000 ug/l
2017-10-06T23:10:45.620Z,1507331445.620 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:10:45.737Z,1507331445.737 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:10:45.752Z,1507331445.752 [CBIT](INFO): Clearing failed state for component MassServo
2017-10-06T23:10:45.752Z,1507331445.752 [MassServo] No Fault, FailCount= 4
2017-10-06T23:10:46.076Z,1507331446.076 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.368900 ug/l
2017-10-06T23:10:46.859Z,1507331446.859 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.523600 ug/l
2017-10-06T23:10:48.469Z,1507331448.469 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 0.499800 ug/l
2017-10-06T23:10:49.655Z,1507331449.655 [MassServo](FAULT): Overload Error
2017-10-06T23:10:49.655Z,1507331449.655 [MassServo] Hardware Fault, FailCount= 5
2017-10-06T23:10:49.655Z,1507331449.655 [MassServo](ERROR): Hardware Fault
2017-10-06T23:10:49.661Z,1507331449.661 [CBIT](ERROR): Hardware Fault in component: MassServo
2017-10-06T23:10:49.661Z,1507331449.661 [CBIT](CRITICAL): Hardware Fault in component: MassServo
2017-10-06T23:10:50.029Z,1507331450.029 [MassServo](DEBUG): Uninitialize Mass Servo.
2017-10-06T23:10:50.029Z,1507331450.029 [MassServo](INFO): Powering down
2017-10-06T23:10:50.045Z,1507331450.045 [CBIT](INFO): Critical error at 20171006T231049
2017-10-06T23:10:50.045Z,1507331450.045 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2017-10-06T23:10:50.362Z,1507331450.362 [PNI_TCM](ERROR): CRC does not match. Expected:0x48771 got:0x1287
2017-10-06T23:10:50.424Z,1507331450.424 [MissionManager](INFO): MissionManager is completed.
2017-10-06T23:10:50.425Z,1507331450.425 [MissionManager](INFO): Uninitializing Mission Science
2017-10-06T23:10:50.425Z,1507331450.425 [Science] Stopped
2017-10-06T23:10:50.425Z,1507331450.425 [Science](DEBUG): Aggregate::uninitialize Science
2017-10-06T23:10:50.425Z,1507331450.425 [Science:A] Stopped
2017-10-06T23:10:50.425Z,1507331450.425 [Science:C] Stopped
2017-10-06T23:10:50.425Z,1507331450.425 [Science:F] Stopped
2017-10-06T23:10:50.527Z,1507331450.527 [Reporter](INFO): mass_concentration_of_chlorophyll_in_sea_water 28.036400 ug/l
2017-10-06T23:10:50.792Z,1507331450.792 [MissionManager](IMPORTANT): Started mission Default
2017-10-06T23:10:50.792Z,1507331450.792 [Default] Running Loop=1
2017-10-06T23:10:50.792Z,1507331450.792 [Default](DEBUG): Aggregate::initialize Default
2017-10-06T23:10:50.792Z,1507331450.792 [Default:B.GoToSurface] Running Loop=1
2017-10-06T23:10:50.793Z,1507331450.793 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2017-10-06T23:10:50.793Z,1507331450.793 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2017-10-06T23:10:50.793Z,1507331450.793 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2017-10-06T23:10:50.793Z,1507331450.793 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2017-10-06T23:10:50.794Z,1507331450.794 [Default:B.GoToSurface](DEBUG): No pitch timeout specified. Using default value of 20.000000 seconds.
2017-10-06T23:10:50.809Z,1507331450.809 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2017-10-06T23:10:50.809Z,1507331450.809 [Default:A.Wait] Running Loop=1
2017-10-06T23:10:50.809Z,1507331450.809 [Default:A.Wait](DEBUG): Initialize Wait Component.
2017-10-06T23:10:50.829Z,1507331450.829 [MassServo](DEBUG): Initializing EZServoServo.
2017-10-06T23:10:50.952Z,1507331450.952 [MassServo](DEBUG): Initializing MassServo.
2017-10-06T23:10:51.159Z,1507331451.159 [WetLabsBB2FL](INFO): Powering down
2017-10-06T23:10:59.952Z,1507331459.952 [PNI_TCM](ERROR): CRC does not match. Expected:0x18161 got:0x49716
2017-10-06T23:11:01.557Z,1507331461.557 [PNI_TCM](ERROR): CRC does not match. Expected:0x5823 got:0x24344
2017-10-06T23:11:03.000Z,1507331464.000 [Default:A.Wait](INFO): Done Waiting.
2017-10-06T23:11:03.000Z,1507331464.000 [Default:A.Wait] Stopped
2017-10-06T23:11:04.000Z,1507331464.000 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2017-10-06T23:11:04.396Z,1507331464.396 [Default:CheckIn] Running Loop=1
2017-10-06T23:11:04.396Z,1507331464.396 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2017-10-06T23:11:04.396Z,1507331464.396 [Default:CheckIn:Read_GPS] Running Loop=1
2017-10-06T23:11:04.749Z,1507331464.749 [PNI_TCM](ERROR): CRC does not match. Expected:0x28438 got:0x7618
2017-10-06T23:11:05.674Z,1507331465.674 [NavChartDb](INFO): # of records loaded: 15000
2017-10-06T23:11:12.752Z,1507331472.752 [PNI_TCM](ERROR): CRC does not match. Expected:0x47458 got:0x59655
2017-10-06T23:11:20.756Z,1507331480.756 [PNI_TCM](ERROR): CRC does not match. Expected:0x32890 got:0x21558
2017-10-06T23:11:24.011Z,1507331484.011 [DeadReckonUsingMultipleVelocitySources](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:11:24.011Z,1507331484.011 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2017-10-06T23:11:24.011Z,1507331484.011 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2017-10-06T23:11:24.013Z,1507331484.013 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2017-10-06T23:11:24.013Z,1507331484.013 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2017-10-06T23:11:24.013Z,1507331484.013 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2017-10-06T23:11:24.087Z,1507331484.087 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2017-10-06T23:11:24.088Z,1507331484.088 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2017-10-06T23:11:24.423Z,1507331484.423 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2017-10-06T23:11:24.424Z,1507331484.424 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2017-10-06T23:11:24.426Z,1507331484.426 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2017-10-06T23:11:24.427Z,1507331484.427 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2017-10-06T23:11:24.790Z,1507331484.790 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2017-10-06T23:11:24.790Z,1507331484.790 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:11:24.791Z,1507331484.791 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:11:24.795Z,1507331484.795 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2017-10-06T23:11:24.797Z,1507331484.797 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2017-10-06T23:11:24.798Z,1507331484.798 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2017-10-06T23:11:25.215Z,1507331485.215 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.2 s old, using for 20.0 s.
2017-10-06T23:11:25.592Z,1507331485.592 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 1.6 s old, using for 20.0 s.
2017-10-06T23:11:25.993Z,1507331485.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.0 s old, using for 20.0 s.
2017-10-06T23:11:26.389Z,1507331486.389 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.4 s old, using for 20.0 s.
2017-10-06T23:11:26.789Z,1507331486.789 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 2.8 s old, using for 20.0 s.
2017-10-06T23:11:27.151Z,1507331487.151 [PNI_TCM](ERROR): CRC does not match. Expected:0x59436 got:0x6210
2017-10-06T23:11:27.208Z,1507331487.208 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.2 s old, using for 20.0 s.
2017-10-06T23:11:27.591Z,1507331487.591 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 3.6 s old, using for 20.0 s.
2017-10-06T23:11:27.983Z,1507331487.983 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.0 s old, using for 20.0 s.
2017-10-06T23:11:28.393Z,1507331488.393 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.4 s old, using for 20.0 s.
2017-10-06T23:11:28.787Z,1507331488.787 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 4.8 s old, using for 20.0 s.
2017-10-06T23:11:29.198Z,1507331489.198 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.2 s old, using for 20.0 s.
2017-10-06T23:11:29.565Z,1507331489.565 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 5.6 s old, using for 20.0 s.
2017-10-06T23:11:29.988Z,1507331489.988 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.0 s old, using for 20.0 s.
2017-10-06T23:11:30.390Z,1507331490.390 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.4 s old, using for 20.0 s.
2017-10-06T23:11:30.783Z,1507331490.783 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 6.8 s old, using for 20.0 s.
2017-10-06T23:11:31.192Z,1507331491.192 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.2 s old, using for 20.0 s.
2017-10-06T23:11:31.593Z,1507331491.593 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 7.6 s old, using for 20.0 s.
2017-10-06T23:11:31.973Z,1507331491.973 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.0 s old, using for 20.0 s.
2017-10-06T23:11:32.384Z,1507331492.384 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.4 s old, using for 20.0 s.
2017-10-06T23:11:32.803Z,1507331492.803 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 8.8 s old, using for 20.0 s.
2017-10-06T23:11:33.201Z,1507331493.201 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 9.2 s old, using for 20.0 s.
2017-10-06T23:11:39.708Z,1507331499.708 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.7 s old, using for 20.0 s.
2017-10-06T23:11:39.909Z,1507331499.909 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 15.9 s old, using for 20.0 s.
2017-10-06T23:11:40.230Z,1507331500.230 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.2 s old, using for 20.0 s.
2017-10-06T23:11:40.640Z,1507331500.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 16.7 s old, using for 20.0 s.
2017-10-06T23:11:41.025Z,1507331501.025 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.0 s old, using for 20.0 s.
2017-10-06T23:11:41.420Z,1507331501.420 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.4 s old, using for 20.0 s.
2017-10-06T23:11:41.809Z,1507331501.809 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 17.8 s old, using for 20.0 s.
2017-10-06T23:11:42.216Z,1507331502.216 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.2 s old, using for 20.0 s.
2017-10-06T23:11:42.605Z,1507331502.605 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 18.6 s old, using for 20.0 s.
2017-10-06T23:11:43.013Z,1507331503.013 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.0 s old, using for 20.0 s.
2017-10-06T23:11:43.464Z,1507331503.464 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.5 s old, using for 20.0 s.
2017-10-06T23:11:43.825Z,1507331503.825 [DeadReckonUsingMultipleVelocitySources](DEBUG): Bottom track data is 19.8 s old, using for 20.0 s.
2017-10-06T23:12:26.677Z,1507331546.677 [NavChartDb](INFO): # of records loaded: 20000
2017-10-06T23:12:29.560Z,1507331549.560 [CommandLine](IMPORTANT): got command configSet BPC1.loadAtStartup 0.000000 bool persist
2017-10-06T23:12:29.561Z,1507331549.561 [CommandLine](IMPORTANT): configSet BPC1.loadAtStartup requires a restart to take effect.
2017-10-06T23:12:32.680Z,1507331552.680 [CommandLine](IMPORTANT): got command restart application
2017-10-06T23:12:33.728Z,1507331553.728 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T23:12:33.728Z,1507331553.728 [CommandLine ThreadHandler](INFO): Thread cancelled.
2017-10-06T23:12:33.902Z,1507331553.902 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2017-10-06T23:12:33.902Z,1507331553.902 [CommandLine ThreadHandler](INFO): Thread cancelled.
2017-10-06T23:12:33.903Z,1507331553.903 [CommandLine](INFO): Join timeout helper Thread ID is 3330
2017-10-06T23:12:33.904Z,1507331553.904 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2017-10-06T23:12:33.904Z,1507331553.904 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2017-10-06T23:12:33.905Z,1507331553.905 [NavChartDb](INFO): Join timeout helper Thread ID is 3331
2017-10-06T23:12:33.999Z,1507331553.999 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T23:12:33.999Z,1507331553.999 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2017-10-06T23:12:34.002Z,1507331554.002 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2017-10-06T23:12:34.002Z,1507331554.002 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2017-10-06T23:12:34.003Z,1507331554.003 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3332
2017-10-06T23:12:34.283Z,1507331554.283 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2017-10-06T23:12:34.283Z,1507331554.283 [WetLabsBB2FL](INFO): Powering down
2017-10-06T23:12:34.284Z,1507331554.284 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2017-10-06T23:12:34.294Z,1507331554.294 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2017-10-06T23:12:34.294Z,1507331554.294 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2017-10-06T23:12:34.295Z,1507331554.295 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 3333
2017-10-06T23:12:42.342Z,1507331562.342 [PNI_TCM](ERROR): CRC does not match. Expected:0x13764 got:0x10501
2017-10-06T23:12:43.944Z,1507331563.944 [PNI_TCM](ERROR): CRC does not match. Expected:0x24276 got:0x49640
2017-10-06T23:12:47.144Z,1507331567.144 [PNI_TCM](ERROR): CRC does not match. Expected:0x23680 got:0x49455
2017-10-06T23:12:48.405Z,1507331568.405 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:12:48.405Z,1507331568.405 [Aanderaa_O2] No Fault, FailCount= 3
2017-10-06T23:12:48.744Z,1507331568.744 [PNI_TCM](ERROR): CRC does not match. Expected:0x60469 got:0x43636
2017-10-06T23:12:50.348Z,1507331570.348 [PNI_TCM](ERROR): CRC does not match. Expected:0x21683 got:0x49680
2017-10-06T23:12:50.359Z,1507331570.359 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:12:50.359Z,1507331570.359 [Aanderaa_O2] Data Fault, FailCount= 1
2017-10-06T23:12:50.359Z,1507331570.359 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:12:50.407Z,1507331570.407 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:12:50.863Z,1507331570.863 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:12:51.576Z,1507331571.576 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:12:51.576Z,1507331571.576 [Aanderaa_O2] No Fault, FailCount= 1
2017-10-06T23:12:53.539Z,1507331573.539 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:12:53.540Z,1507331573.540 [Aanderaa_O2] Data Fault, FailCount= 2
2017-10-06T23:12:53.540Z,1507331573.540 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:12:53.599Z,1507331573.599 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:12:54.054Z,1507331574.054 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:12:54.786Z,1507331574.786 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2017-10-06T23:12:54.786Z,1507331574.786 [Aanderaa_O2] No Fault, FailCount= 2
2017-10-06T23:12:56.740Z,1507331576.740 [PNI_TCM](ERROR): CRC does not match. Expected:0x13764 got:0x10501
2017-10-06T23:12:56.755Z,1507331576.755 [Aanderaa_O2](DEBUG): Error parsing data: StartupInfo	4831F	14	Mode	AADI Smart Sensor Terminal Protocol	RS232 Protocol Version	3	Config Version	12

2017-10-06T23:12:56.755Z,1507331576.755 [Aanderaa_O2] Data Fault, FailCount= 3
2017-10-06T23:12:56.755Z,1507331576.755 [Aanderaa_O2](ERROR): Data Fault
2017-10-06T23:12:56.791Z,1507331576.791 [CBIT](ERROR): Data Fault in component: Aanderaa_O2
2017-10-06T23:12:56.791Z,1507331576.791 [CBIT](FAULT): Data Fault in component: Aanderaa_O2
2017-10-06T23:12:57.260Z,1507331577.260 [Aanderaa_O2](INFO): Powering down
2017-10-06T23:12:58.344Z,1507331578.344 [PNI_TCM](ERROR): CRC does not match. Expected:0x58931 got:0x45672
2017-10-06T23:12:59.944Z,1507331579.944 [PNI_TCM](ERROR): CRC does not match. Expected:0x61411 got:0x17236
2017-10-06T23:13:03.144Z,1507331583.144 [PNI_TCM](ERROR): CRC does not match. Expected:0x1581 got:0x13481