2018-10-16T19:27:50.867Z,1539718070.867 [Supervisor](DEBUG): Initializing supervisor.
2018-10-16T19:27:50.871Z,1539718070.871 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-10-16T19:27:50.872Z,1539718070.872 [SyncHandler](INFO): Protected caller Thread ID is 1175
2018-10-16T19:27:50.872Z,1539718070.872 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-10-16T19:27:50.873Z,1539718070.873 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-10-16T19:27:50.873Z,1539718070.873 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1176
2018-10-16T19:27:50.877Z,1539718070.877 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-10-16T19:27:50.889Z,1539718070.889 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-10-16T19:27:50.890Z,1539718070.890 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-10-16T19:27:50.891Z,1539718070.891 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1177
2018-10-16T19:27:50.891Z,1539718070.891 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-10-16T19:27:50.892Z,1539718070.892 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-10-16T19:27:50.893Z,1539718070.893 [logger ThreadHandler](INFO): Protected caller Thread ID is 1178
2018-10-16T19:27:50.895Z,1539718070.895 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-10-16T19:27:50.895Z,1539718070.895 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-10-16T19:27:50.897Z,1539718070.897 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-10-16T19:27:51.226Z,1539718071.226 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-10-16T19:27:51.227Z,1539718071.227 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-10-16T19:27:51.428Z,1539718071.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-10-16T19:27:51.428Z,1539718071.428 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-10-16T19:27:51.739Z,1539718071.739 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-10-16T19:27:51.740Z,1539718071.740 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-10-16T19:27:52.104Z,1539718072.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-10-16T19:27:52.105Z,1539718072.105 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-10-16T19:27:52.204Z,1539718072.204 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-10-16T19:27:52.205Z,1539718072.205 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-10-16T19:27:52.671Z,1539718072.671 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-10-16T19:27:52.672Z,1539718072.672 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-10-16T19:27:53.135Z,1539718073.135 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-10-16T19:27:53.136Z,1539718073.136 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-10-16T19:27:53.607Z,1539718073.607 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-10-16T19:27:53.607Z,1539718073.607 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-10-16T19:27:53.712Z,1539718073.712 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-10-16T19:27:53.712Z,1539718073.712 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-10-16T19:27:53.810Z,1539718073.810 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-10-16T19:27:53.810Z,1539718073.810 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-10-16T19:27:54.031Z,1539718074.031 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-10-16T19:27:54.031Z,1539718074.031 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-10-16T19:27:54.236Z,1539718074.236 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-10-16T19:27:54.237Z,1539718074.237 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-10-16T19:27:54.593Z,1539718074.593 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-10-16T19:27:54.594Z,1539718074.594 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-10-16T19:27:54.740Z,1539718074.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-10-16T19:27:54.741Z,1539718074.741 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-10-16T19:27:54.823Z,1539718074.823 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2018-10-16T19:27:54.824Z,1539718074.824 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2018-10-16T19:27:54.927Z,1539718074.927 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2018-10-16T19:27:55.046Z,1539718075.046 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2018-10-16T19:27:55.140Z,1539718075.140 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2018-10-16T19:27:55.226Z,1539718075.226 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2018-10-16T19:27:55.391Z,1539718075.391 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2018-10-16T19:27:55.572Z,1539718075.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2018-10-16T19:27:55.647Z,1539718075.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2018-10-16T19:27:55.883Z,1539718075.883 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-10-16T19:27:55.883Z,1539718075.883 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2018-10-16T19:27:55.966Z,1539718075.966 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2018-10-16T19:27:56.058Z,1539718076.058 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2018-10-16T19:27:56.159Z,1539718076.159 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2018-10-16T19:27:56.287Z,1539718076.287 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2018-10-16T19:27:56.287Z,1539718076.287 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-10-16T19:27:56.299Z,1539718076.299 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-10-16T19:27:56.554Z,1539718076.554 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-10-16T19:27:56.555Z,1539718076.555 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-10-16T19:27:56.599Z,1539718076.599 [DepthRateCalculator] Loaded
2018-10-16T19:27:56.600Z,1539718076.600 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-10-16T19:27:56.606Z,1539718076.606 [PitchRateCalculator] Loaded
2018-10-16T19:27:56.606Z,1539718076.606 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-10-16T19:27:56.623Z,1539718076.623 [SpeedCalculator] Loaded
2018-10-16T19:27:56.623Z,1539718076.623 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-10-16T19:27:56.645Z,1539718076.645 [TempGradientCalculator] Loaded
2018-10-16T19:27:56.645Z,1539718076.645 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-10-16T19:27:56.651Z,1539718076.651 [YawRateCalculator] Loaded
2018-10-16T19:27:56.652Z,1539718076.652 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-10-16T19:27:56.692Z,1539718076.692 [ElevatorOffsetCalculator] Loaded
2018-10-16T19:27:56.693Z,1539718076.693 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-10-16T19:27:56.693Z,1539718076.693 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-10-16T19:27:56.694Z,1539718076.694 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-10-16T19:27:56.764Z,1539718076.764 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-10-16T19:27:56.765Z,1539718076.765 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-10-16T19:27:57.107Z,1539718077.107 [BuoyancyServo] Loaded
2018-10-16T19:27:57.107Z,1539718077.107 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-10-16T19:27:57.181Z,1539718077.181 [ElevatorServo] Loaded
2018-10-16T19:27:57.181Z,1539718077.181 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-10-16T19:27:57.232Z,1539718077.232 [MassServo] Loaded
2018-10-16T19:27:57.232Z,1539718077.232 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-10-16T19:27:57.327Z,1539718077.327 [RudderServo] Loaded
2018-10-16T19:27:57.327Z,1539718077.327 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-10-16T19:27:57.421Z,1539718077.421 [ThrusterServo] Loaded
2018-10-16T19:27:57.422Z,1539718077.422 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-10-16T19:27:57.422Z,1539718077.422 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-10-16T19:27:57.423Z,1539718077.423 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-10-16T19:27:57.479Z,1539718077.479 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-10-16T19:27:57.480Z,1539718077.480 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-10-16T19:27:57.732Z,1539718077.732 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-10-16T19:27:57.732Z,1539718077.732 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-10-16T19:27:58.045Z,1539718078.045 [DataOverHttps] Loaded
2018-10-16T19:27:58.045Z,1539718078.045 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-10-16T19:27:58.059Z,1539718078.059 [Depth_Keller] Loaded
2018-10-16T19:27:58.059Z,1539718078.059 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-10-16T19:27:58.064Z,1539718078.064 [DropWeight] Loaded
2018-10-16T19:27:58.065Z,1539718078.065 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-10-16T19:27:58.165Z,1539718078.165 [NAL9602] Loaded
2018-10-16T19:27:58.166Z,1539718078.166 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-10-16T19:27:58.182Z,1539718078.182 [Onboard] Loaded
2018-10-16T19:27:58.182Z,1539718078.182 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-10-16T19:27:58.193Z,1539718078.193 [Radio_Surface] Loaded
2018-10-16T19:27:58.193Z,1539718078.193 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-10-16T19:27:58.194Z,1539718078.194 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4088F4E0
2018-10-16T19:27:58.195Z,1539718078.195 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1260
2018-10-16T19:27:58.243Z,1539718078.243 [PNI_TCM] Loaded
2018-10-16T19:27:58.243Z,1539718078.243 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-10-16T19:27:58.305Z,1539718078.305 [Rowe_600LCM] Loaded
2018-10-16T19:27:58.305Z,1539718078.305 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2018-10-16T19:27:58.306Z,1539718078.306 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 408BF4E0
2018-10-16T19:27:58.307Z,1539718078.307 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 1261
2018-10-16T19:27:58.307Z,1539718078.307 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-10-16T19:27:58.308Z,1539718078.308 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-10-16T19:27:58.447Z,1539718078.447 [SBIT](DEBUG): Construct Startup Built In Test.
2018-10-16T19:27:58.469Z,1539718078.469 [SBIT] Loaded
2018-10-16T19:27:58.469Z,1539718078.469 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-10-16T19:27:58.470Z,1539718078.470 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-10-16T19:27:58.483Z,1539718078.483 [IBIT] Loaded
2018-10-16T19:27:58.483Z,1539718078.483 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-10-16T19:27:58.486Z,1539718078.486 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-10-16T19:27:58.638Z,1539718078.638 [CBIT] Loaded
2018-10-16T19:27:58.639Z,1539718078.639 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-10-16T19:27:58.639Z,1539718078.639 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-10-16T19:27:58.639Z,1539718078.639 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-10-16T19:27:58.807Z,1539718078.807 [Aanderaa_O2] Loaded
2018-10-16T19:27:58.807Z,1539718078.807 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-10-16T19:27:58.822Z,1539718078.822 [PAR_Licor] Loaded
2018-10-16T19:27:58.823Z,1539718078.823 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-10-16T19:27:58.873Z,1539718078.873 [WetLabsBB2FL] Loaded
2018-10-16T19:27:58.873Z,1539718078.873 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-10-16T19:27:58.875Z,1539718078.875 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4098A4E0
2018-10-16T19:27:58.875Z,1539718078.875 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1262
2018-10-16T19:27:58.876Z,1539718078.876 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-10-16T19:27:58.876Z,1539718078.876 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-10-16T19:27:58.948Z,1539718078.948 [VerticalControl](DEBUG): Construct VerticalControl.
2018-10-16T19:27:59.036Z,1539718079.036 [VerticalControl] Loaded
2018-10-16T19:27:59.036Z,1539718079.036 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-10-16T19:27:59.037Z,1539718079.037 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-10-16T19:27:59.096Z,1539718079.096 [HorizontalControl] Loaded
2018-10-16T19:27:59.096Z,1539718079.096 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-10-16T19:27:59.097Z,1539718079.097 [SpeedControl](DEBUG): Construct SpeedControl.
2018-10-16T19:27:59.098Z,1539718079.098 [SpeedControl] Loaded
2018-10-16T19:27:59.099Z,1539718079.099 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-10-16T19:27:59.099Z,1539718079.099 [LoopControl](DEBUG): Construct LoopControl.
2018-10-16T19:27:59.100Z,1539718079.100 [LoopControl] Loaded
2018-10-16T19:27:59.100Z,1539718079.100 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-10-16T19:27:59.101Z,1539718079.101 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-10-16T19:27:59.101Z,1539718079.101 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-10-16T19:27:59.127Z,1539718079.127 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-10-16T19:27:59.128Z,1539718079.128 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-10-16T19:27:59.221Z,1539718079.221 [DeadReckonUsingSpeedCalculator] Loaded
2018-10-16T19:27:59.221Z,1539718079.221 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-10-16T19:27:59.238Z,1539718079.238 [NavChart] Loaded
2018-10-16T19:27:59.238Z,1539718079.238 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-10-16T19:27:59.242Z,1539718079.242 [UniversalFixResidualReporter] Loaded
2018-10-16T19:27:59.242Z,1539718079.242 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-10-16T19:27:59.243Z,1539718079.243 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-10-16T19:27:59.246Z,1539718079.246 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-10-16T19:27:59.247Z,1539718079.247 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-10-16T19:27:59.255Z,1539718079.255 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-10-16T19:27:59.256Z,1539718079.256 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2018-10-16T19:27:59.256Z,1539718079.256 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1263
2018-10-16T19:27:59.261Z,1539718079.261 [Supervisor](INFO): Main Thread ID is 796
2018-10-16T19:27:59.261Z,1539718079.261 [Supervisor](DEBUG): Running supervisor.
2018-10-16T19:27:59.262Z,1539718079.262 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1264
2018-10-16T19:27:59.265Z,1539718079.265 [controlThread ThreadHandler](INFO): Handler Thread ID is 1265
2018-10-16T19:27:59.265Z,1539718079.265 [controlThread](DEBUG): Initializing ControlThread
2018-10-16T19:27:59.266Z,1539718079.266 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-10-16T19:27:59.266Z,1539718079.266 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-10-16T19:27:59.267Z,1539718079.267 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-10-16T19:27:59.267Z,1539718079.267 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-10-16T19:27:59.267Z,1539718079.267 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-10-16T19:27:59.268Z,1539718079.268 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-10-16T19:27:59.275Z,1539718079.275 [SBIT](INFO): Initialize SBIT Component.
2018-10-16T19:27:59.275Z,1539718079.275 [SBIT](IMPORTANT): git: 2018-10-09-25-gf1894f1
2018-10-16T19:27:59.276Z,1539718079.276 [SBIT](INFO): git hash: f1894f15ea8e4c49c3f23e64e2ef160a516712eb
2018-10-16T19:27:59.276Z,1539718079.276 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-10-16T19:27:59.276Z,1539718079.276 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-10-16T19:27:59.277Z,1539718079.277 [SBIT](INFO): Beginning SBIT in 36.000000 seconds.
2018-10-16T19:27:59.278Z,1539718079.278 [IBIT](INFO): Initialize IBIT Component.
2018-10-16T19:27:59.279Z,1539718079.279 [CBIT](DEBUG): Initialize CBIT Component.
2018-10-16T19:27:59.279Z,1539718079.279 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-10-16T19:27:59.280Z,1539718079.280 [logger ThreadHandler](INFO): Handler Thread ID is 1266
2018-10-16T19:27:59.297Z,1539718079.297 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1267
2018-10-16T19:27:59.303Z,1539718079.303 [Radio_Surface](INFO): Powering up
2018-10-16T19:27:59.309Z,1539718079.309 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 1268
2018-10-16T19:27:59.310Z,1539718079.310 [Rowe_600LCM](INFO): Initializing
2018-10-16T19:27:59.310Z,1539718079.310 [Rowe_600LCM](INFO): Checking LCM
2018-10-16T19:27:59.319Z,1539718079.319 [Rowe_600LCM](INFO): LCM OK
2018-10-16T19:27:59.319Z,1539718079.319 [Rowe_600LCM](INFO): Powering up
2018-10-16T19:27:59.325Z,1539718079.325 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1269
2018-10-16T19:27:59.327Z,1539718079.327 [WetLabsBB2FL](INFO): Powering down
2018-10-16T19:27:59.353Z,1539718079.353 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1270
2018-10-16T19:27:59.357Z,1539718079.357 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-10-16T19:27:59.357Z,1539718079.357 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-10-16T19:27:59.357Z,1539718079.357 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-10-16T19:27:59.357Z,1539718079.357 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-10-16T19:27:59.358Z,1539718079.358 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-10-16T19:27:59.358Z,1539718079.358 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-10-16T19:27:59.358Z,1539718079.358 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-10-16T19:27:59.358Z,1539718079.358 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-10-16T19:27:59.358Z,1539718079.358 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-10-16T19:27:59.359Z,1539718079.359 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-10-16T19:27:59.359Z,1539718079.359 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-10-16T19:27:59.359Z,1539718079.359 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-10-16T19:27:59.359Z,1539718079.359 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-10-16T19:27:59.359Z,1539718079.359 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-10-16T19:27:59.360Z,1539718079.360 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-10-16T19:27:59.360Z,1539718079.360 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-10-16T19:27:59.389Z,1539718079.389 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-10-16T19:27:59.391Z,1539718079.391 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-10-16T19:27:59.392Z,1539718079.392 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-10-16T19:27:59.392Z,1539718079.392 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-10-16T19:27:59.393Z,1539718079.393 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-16T19:27:59.393Z,1539718079.393 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-16T19:27:59.394Z,1539718079.394 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-16T19:27:59.394Z,1539718079.394 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-10-16T19:27:59.395Z,1539718079.395 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-10-16T19:27:59.396Z,1539718079.396 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-10-16T19:27:59.420Z,1539718079.420 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-10-16T19:27:59.443Z,1539718079.443 [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>


2018-10-16T19:27:59.444Z,1539718079.444 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-10-16T19:27:59.539Z,1539718079.539 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-10-16T19:27:59.540Z,1539718079.540 [Default:A.Wait](DEBUG): Construct Wait.
2018-10-16T19:27:59.542Z,1539718079.542 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-10-16T19:27:59.581Z,1539718079.581 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-10-16T19:27:59.583Z,1539718079.583 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-10-16T19:27:59.596Z,1539718079.596 [Default:E.Execute](DEBUG): Construct Execute.
2018-10-16T19:27:59.600Z,1539718079.600 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <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">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</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>


2018-10-16T19:27:59.609Z,1539718079.609 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,Aanderaa_O2,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-10-16T19:27:59.637Z,1539718079.637 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-10-16T19:28:00.110Z,1539718080.110 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-10-16T19:28:00.117Z,1539718080.117 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-10-16T19:28:00.124Z,1539718080.124 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-10-16T19:28:00.130Z,1539718080.130 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-10-16T19:28:00.136Z,1539718080.136 [MassServo](DEBUG): Initializing EZServoServo.
2018-10-16T19:28:00.141Z,1539718080.141 [MassServo](DEBUG): Initializing MassServo.
2018-10-16T19:28:00.163Z,1539718080.163 [RudderServo](DEBUG): Initializing EZServoServo.
2018-10-16T19:28:00.169Z,1539718080.169 [RudderServo](DEBUG): Initializing RudderServo.
2018-10-16T19:28:00.175Z,1539718080.175 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-10-16T19:28:00.181Z,1539718080.181 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-10-16T19:28:03.309Z,1539718083.309 [Aanderaa_O2](INFO): Powering down
2018-10-16T19:28:03.724Z,1539718083.724 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-10-16T19:28:03.876Z,1539718083.876 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-10-16T19:28:03.930Z,1539718083.930 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-10-16T19:28:03.931Z,1539718083.931 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-10-16T19:28:03.931Z,1539718083.931 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-10-16T19:28:28.475Z,1539718108.475 [NAL9602](INFO): Powering up NAL9602
2018-10-16T19:28:35.748Z,1539718115.748 [SBIT](IMPORTANT): Beginning Startup BIT
2018-10-16T19:28:35.760Z,1539718115.760 [CBIT](IMPORTANT): Beginning ground fault scan
2018-10-16T19:28:39.423Z,1539718119.423 [NAL9602](INFO): NAL9602 initialized
2018-10-16T19:28:44.230Z,1539718124.230 [CommandLine](IMPORTANT): got command failComponent
2018-10-16T19:28:44.230Z,1539718124.230 [CommandLine](IMPORTANT): Failed components:
2018-10-16T19:28:44.231Z,1539718124.231 [CommandLine](IMPORTANT): No failed Components.
2018-10-16T19:28:47.092Z,1539718127.092 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.004766
CHAN A1 (24V): -0.008985
CHAN A2 (12V): -0.002392
CHAN A3 (5V): -0.001277
CHAN B0 (3.3V): -0.000358
CHAN B1 (3.15aV): -0.000040
CHAN B2 (3.15bV): 0.000145
CHAN B3 (GND): 0.000056
OPEN: -0.000261
Full Scale Calc: 4.765 mA, -1.589 mA
2018-10-16T19:29:29.830Z,1539718169.830 [SBIT](IMPORTANT): SBIT PASSED
2018-10-16T19:29:29.871Z,1539718169.871 [CommandLine](IMPORTANT): got command configSet list
2018-10-16T19:29:29.872Z,1539718169.872 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-10-16T19:29:29.872Z,1539718169.872 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=25 count;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): BPC1.batteryMuxCycleTime=10 minute;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=1 minute;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): BPC1.loadAtStartup=0 bool;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): Express none VerticalTemperatureHomogeneityIndexCalculator.vertical_temperature_homogeneity_index;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2018-10-16T19:29:29.873Z,1539718169.873 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=1 bool;

2018-10-16T19:29:29.874Z,1539718169.874 [CommandLine](IMPORTANT): StratificationFrontDetector.loadAtStartup=0 bool;

2018-10-16T19:29:29.874Z,1539718169.874 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=213 cubic_centimeter;

2018-10-16T19:29:29.874Z,1539718169.874 [CommandLine](IMPORTANT): VerticalControl.massDefault=4 millimeter;

2018-10-16T19:29:30.228Z,1539718170.228 [MissionManager](IMPORTANT): Started mission Startup
2018-10-16T19:29:30.229Z,1539718170.229 [Startup] Running Loop=1
2018-10-16T19:29:30.229Z,1539718170.229 [Startup](DEBUG): Aggregate::initialize Startup
2018-10-16T19:29:30.229Z,1539718170.229 [Startup:A.GoToSurface] Running Loop=1
2018-10-16T19:29:30.229Z,1539718170.229 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-10-16T19:29:30.230Z,1539718170.230 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-10-16T19:29:30.230Z,1539718170.230 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-10-16T19:29:30.231Z,1539718170.231 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-10-16T19:29:30.231Z,1539718170.231 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-10-16T19:29:30.231Z,1539718170.231 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-10-16T19:29:30.238Z,1539718170.238 [Startup:StartupSatComms] Running Loop=1
2018-10-16T19:29:30.238Z,1539718170.238 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-10-16T19:29:30.238Z,1539718170.238 [Startup:StartupSatComms:A] Running Loop=1
2018-10-16T19:29:30.637Z,1539718170.637 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-10-16T19:30:30.635Z,1539718230.635 [Startup:StartupSatComms:A](INFO): Timed out from 2018-10-16T19:29:30.2Z
2018-10-16T19:30:30.635Z,1539718230.635 [Startup:StartupSatComms:A] Stopped
2018-10-16T19:30:30.635Z,1539718230.635 [Startup:StartupSatComms:B] Running Loop=1
2018-10-16T19:30:31.075Z,1539718231.075 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-10-16T19:30:59.443Z,1539718259.443 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-10-16T19:30:59.443Z,1539718259.443 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-10-16T19:30:59.443Z,1539718259.443 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-16T19:30:59.456Z,1539718259.456 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-16T19:30:59.854Z,1539718259.854 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-16T19:30:59.854Z,1539718259.854 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-10-16T19:31:00.214Z,1539718260.214 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-16T19:31:00.215Z,1539718260.215 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-16T19:31:00.215Z,1539718260.215 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-16T19:31:05.214Z,1539718265.214 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004092
2018-10-16T19:31:09.526Z,1539718269.526 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20181016T190505/Courier0010.lzma
2018-10-16T19:31:10.283Z,1539718270.283 [DataOverHttps](INFO): Moved sent file to Logs/20181016T190505/Courier0010.lzma.bak
2018-10-16T19:31:10.283Z,1539718270.283 [DataOverHttps](INFO): SBD MOMSN=8719503
2018-10-16T19:31:25.158Z,1539718285.158 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20181016T190505/Express0011.lzma
2018-10-16T19:31:25.959Z,1539718285.959 [DataOverHttps](INFO): Moved sent file to Logs/20181016T190505/Express0011.lzma.bak
2018-10-16T19:31:25.959Z,1539718285.959 [DataOverHttps](INFO): SBD MOMSN=8719506
2018-10-16T19:31:30.662Z,1539718290.662 [Startup:StartupSatComms:B](INFO): Timed out from 2018-10-16T19:30:30.6Z
2018-10-16T19:31:30.662Z,1539718290.662 [Startup:StartupSatComms:B] Stopped
2018-10-16T19:31:30.663Z,1539718290.663 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-10-16T19:31:30.663Z,1539718290.663 [Startup:StartupSatComms] Stopped
2018-10-16T19:31:30.663Z,1539718290.663 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-10-16T19:31:30.664Z,1539718290.664 [Startup](INFO): Completed Startup
2018-10-16T19:31:30.664Z,1539718290.664 [MissionManager](INFO): Startup is completed.
2018-10-16T19:31:30.664Z,1539718290.664 [MissionManager](INFO): Uninitializing Mission Startup
2018-10-16T19:31:30.664Z,1539718290.664 [Startup] Stopped
2018-10-16T19:31:30.664Z,1539718290.664 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-10-16T19:31:30.664Z,1539718290.664 [Startup:A.GoToSurface] Stopped
2018-10-16T19:31:30.664Z,1539718290.664 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-10-16T19:31:31.130Z,1539718291.130 [MissionManager](IMPORTANT): Started mission Default
2018-10-16T19:31:31.130Z,1539718291.130 [Default] Running Loop=1
2018-10-16T19:31:31.130Z,1539718291.130 [Default](DEBUG): Aggregate::initialize Default
2018-10-16T19:31:31.130Z,1539718291.130 [Default:B.GoToSurface] Running Loop=1
2018-10-16T19:31:31.130Z,1539718291.130 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-10-16T19:31:31.131Z,1539718291.131 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-10-16T19:31:31.131Z,1539718291.131 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-10-16T19:31:31.132Z,1539718291.132 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-10-16T19:31:31.132Z,1539718291.132 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-10-16T19:31:31.132Z,1539718291.132 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-10-16T19:31:31.136Z,1539718291.136 [Default:A.Wait] Running Loop=1
2018-10-16T19:31:31.137Z,1539718291.137 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-10-16T19:31:35.357Z,1539718295.357 [DataOverHttps](INFO): Sending 961 bytes from file Logs/20181016T192750/Express0001.lzma
2018-10-16T19:31:36.135Z,1539718296.135 [DataOverHttps](INFO): Moved sent file to Logs/20181016T192750/Express0001.lzma.bak
2018-10-16T19:31:36.135Z,1539718296.135 [DataOverHttps](INFO): SBD MOMSN=8719510
2018-10-16T19:31:44.208Z,1539718304.208 [Default:A.Wait](INFO): Done Waiting.
2018-10-16T19:31:44.208Z,1539718304.208 [Default:A.Wait] Stopped
2018-10-16T19:31:44.209Z,1539718304.209 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-10-16T19:31:44.589Z,1539718304.589 [Default:CheckIn] Running Loop=1
2018-10-16T19:31:44.589Z,1539718304.589 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-16T19:31:44.589Z,1539718304.589 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-16T19:31:45.044Z,1539718305.044 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-10-16T19:33:42.895Z,1539718422.895 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-10-16T19:33:55.414Z,1539718435.414 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2018-10-16T19:33:55.414Z,1539718435.414 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2018-10-16T19:33:55.653Z,1539718435.653 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2018-10-16T19:33:55.656Z,1539718435.656 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2018-10-16T19:33:55.660Z,1539718435.660 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2018-10-16T19:33:55.663Z,1539718435.663 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2018-10-16T19:33:55.666Z,1539718435.666 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min
2018-10-16T19:33:55.669Z,1539718435.669 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2018-10-16T19:33:55.672Z,1539718435.672 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2018-10-16T19:33:55.675Z,1539718435.675 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2018-10-16T19:33:55.679Z,1539718435.679 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2018-10-16T19:33:55.682Z,1539718435.682 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2018-10-16T19:33:55.695Z,1539718435.695 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2018-10-16T19:33:55.740Z,1539718435.740 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2018-10-16T19:33:55.755Z,1539718435.755 [MissionManager](INFO): DefineArg Science.PeakDetectFDOMActive = 0 bool
2018-10-16T19:33:55.766Z,1539718435.766 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2018-10-16T19:33:55.781Z,1539718435.781 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 1.000000 bool
2018-10-16T19:33:55.793Z,1539718435.793 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 0.000000 bool
2018-10-16T19:33:55.804Z,1539718435.804 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 0.000000 bool
2018-10-16T19:33:55.812Z,1539718435.812 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2018-10-16T19:33:55.830Z,1539718435.830 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2018-10-16T19:33:55.838Z,1539718435.838 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2018-10-16T19:33:55.845Z,1539718435.845 [MissionManager](INFO): DefineArg Science.EnabledWetLabsUBAT = 0.000000 bool
2018-10-16T19:33:55.853Z,1539718435.853 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2018-10-16T19:33:55.856Z,1539718435.856 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2018-10-16T19:33:55.860Z,1539718435.860 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2018-10-16T19:33:55.880Z,1539718435.880 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2018-10-16T19:33:55.883Z,1539718435.883 [MissionManager](INFO): DefineArg Science.PeakShallowBound = nan m
2018-10-16T19:33:55.899Z,1539718435.899 [MissionManager](INFO): DefineArg Science.PeakDeepBound = nan m
2018-10-16T19:33:55.904Z,1539718435.904 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2018-10-16T19:33:55.925Z,1539718435.925 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2018-10-16T19:33:55.929Z,1539718435.929 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2018-10-16T19:33:55.932Z,1539718435.932 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2018-10-16T19:33:55.948Z,1539718435.948 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2018-10-16T19:33:55.951Z,1539718435.951 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2018-10-16T19:33:55.954Z,1539718435.954 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2018-10-16T19:33:55.970Z,1539718435.970 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2018-10-16T19:33:55.973Z,1539718435.973 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2018-10-16T19:33:55.986Z,1539718435.986 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2018-10-16T19:33:55.989Z,1539718435.989 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2018-10-16T19:33:56.013Z,1539718436.013 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2018-10-16T19:33:56.016Z,1539718436.016 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2018-10-16T19:33:56.023Z,1539718436.023 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2018-10-16T19:33:56.027Z,1539718436.027 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2018-10-16T19:33:56.030Z,1539718436.030 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2018-10-16T19:33:56.046Z,1539718436.046 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2018-10-16T19:33:56.050Z,1539718436.050 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2018-10-16T19:33:56.073Z,1539718436.073 [MissionManager](INFO): DefineOutput Science.PeakFDOM = 0.000000 ppb
2018-10-16T19:33:56.076Z,1539718436.076 [MissionManager](INFO): DefineOutput Science.PeakFDOMDepth = 0.000000 m
2018-10-16T19:33:56.079Z,1539718436.079 [MissionManager](INFO): DefineOutput Science.PeakFDOMLatitude = nan arcdeg
2018-10-16T19:33:56.083Z,1539718436.083 [MissionManager](INFO): DefineOutput Science.PeakFDOMLongitude = nan arcdeg
2018-10-16T19:33:56.114Z,1539718436.114 [MissionManager](INFO): DefineOutput Science.PatchFDOMDistance = nan m
2018-10-16T19:33:56.185Z,1539718436.185 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-10-16T19:33:56.209Z,1539718436.209 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2018-10-16T19:33:56.242Z,1539718436.242 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-10-16T19:33:56.252Z,1539718436.252 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-10-16T19:33:56.266Z,1539718436.266 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-10-16T19:33:56.350Z,1539718436.350 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Aggregate xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
           xmlns="Tethys"
           xmlns:Units="Tethys/Units"
           xmlns:Science="Tethys/Science"
           xmlns:Universal="Tethys/Universal"
           xmlns:Trigger="Tethys/Trigger"
           xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                               Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                               Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                               Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd
                               Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.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="TimeWindowPeakReport"><Description>
        If greater than zero, report a peak every window. If NaN or zero, this
        variable is ignored.
    </Description><Units:minute/><Value>NaN</Value></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>

<!--debug
    </Description><True/></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="OffPeakFractionHorizontal"><Description>
        When filtered horizontal value is this fraction of the peak, consider it
        outside the patch.
    </Description><Units:percent/><Value>80</Value></DefineArg>

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

    <DefineArg Name="PeakDetectOilActive"><Description>
        Turns on peak detection of Dissolved Oil.
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectFDOMActive"><Description>
        Turns on peak detection of concentration_of_colored_dissolved_organic_matter_in_sea_water_expressed_as_equivalent_mass_fraction_of_quinine_sulfate_dihydrate from FDOM sensor.
    </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="EnabledWetLabsSeaOWL_UV_A"><Description>
        Automatically set to true if the the WetLabs SeaOWL UV-A is enabled. Set
        to false to disable the WetLabs SeaOWL UV-A.
    </Description><Science:WetLabsSeaOWL_UV_A.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsUBAT"><Description>
        Automatically set to true if the the WetLabs UBAT is enabled. Set
        to false to disable the WetLabs UBAT.
    </Description><Science:WetLabsUBAT.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="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>

<!--debug
    </Description><Units:meter/><Value>10</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>

<!--debug
    </Description><Units:meter/><Value>20</Value></DefineArg>
-->

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

    <DefineArg Name="PeakDeepBound"><Description>
        Deep depth bound for detecting any 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="PeakChlTemperature"><Units:celsius/><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:meter/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakOil"><Units:kilogram_per_cubic_meter/><Value>0</Value></DefineOutput>

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

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

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

    <DefineOutput Name="PeakFDOM"><Units:part_per_billion/><Value>0</Value></DefineOutput>

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

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

    <DefineOutput Name="PeakFDOMLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>
    
    <DefineOutput Name="PatchFDOMDistance"><Units:meter/><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="EnabledSeabird"/>
        </While>
        <Science:CTD_Seabird.sea_water_temperature/>
        <Science:CTD_Seabird.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>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsUBAT"/>
        </While>
        <Science:WetLabsUBAT.biolum_potential/>
    </ReadData>

<!--debug-->

    <ReadData Id="Read_Oil" Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsSeaOWL_UV_A"/>
            <Or><Arg Name="PeakDetectOilActive"/></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.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></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="PeakChlTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

<!--debug
        <Syslog Severity="Important">PeakChl, PeakChlLatitude, PeakChlLongitude = <Arg Name="PeakChl"/><Units:microgram_per_liter/>, <Arg Name="PeakChlLatitude"/><Units:degree/>, <Arg Name="PeakChlLongitude"/><Units:degree/></Syslog>
-->

        <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>
            <Setting><Trigger:PeakDetectHorizontal.offPeakFraction/><Arg Name="OffPeakFractionHorizontal"/></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>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></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="PeakDetectOil">

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

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_petroleum_hydrocarbons_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakOil"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakOilDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakOilLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakOilLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakOil"/><Arg Name="PeakOilDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectFDOM">

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

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:concentration_of_colored_dissolved_organic_matter_in_sea_water_expressed_as_equivalent_mass_fraction_of_quinine_sulfate_dihydrate/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakFDOM"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakFDOMDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakFDOMTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakFDOMLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakFDOMLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakFDOM"/><Arg Name="PeakFDOMDepth"/>
        </SendData>

    </Aggregate>

</Aggregate>


2018-10-16T19:33:56.353Z,1539718436.353 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2018-10-16T19:33:56.542Z,1539718436.542 [Default] Stopped
2018-10-16T19:33:56.542Z,1539718436.542 [Default](DEBUG): Aggregate::uninitialize Default
2018-10-16T19:33:56.542Z,1539718436.542 [Default:B.GoToSurface] Stopped
2018-10-16T19:33:56.542Z,1539718436.542 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-10-16T19:33:56.542Z,1539718436.542 [Default:CheckIn] Stopped
2018-10-16T19:33:56.543Z,1539718436.543 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-16T19:33:56.543Z,1539718436.543 [Default:CheckIn:Read_GPS] Stopped
2018-10-16T19:33:56.543Z,1539718436.543 [MissionManager](IMPORTANT): Started mission Science
2018-10-16T19:33:56.543Z,1539718436.543 [Science] Running Loop=1
2018-10-16T19:33:56.543Z,1539718436.543 [Science](DEBUG): Aggregate::initialize Science
2018-10-16T19:33:56.543Z,1539718436.543 [Science:A] Running Loop=1
2018-10-16T19:33:56.543Z,1539718436.543 [Science:B] Running Loop=1
2018-10-16T19:33:56.543Z,1539718436.543 [Science:C] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:D] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:E] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:F] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:G] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:H] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:Read_Oil] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:PeakDetectChl] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2018-10-16T19:33:56.544Z,1539718436.544 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2018-10-16T19:33:56.544Z,1539718436.544 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-10-16T19:33:56.558Z,1539718436.558 [Science:HighestChlPeakReport] Running Loop=1
2018-10-16T19:33:56.559Z,1539718436.559 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2018-10-16T19:33:56.559Z,1539718436.559 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2018-10-16T19:33:56.559Z,1539718436.559 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2018-10-16T19:33:56.560Z,1539718436.560 [Science:PeakDetectNO3] Running Loop=1
2018-10-16T19:33:56.560Z,1539718436.560 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2018-10-16T19:33:56.560Z,1539718436.560 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2018-10-16T19:33:56.560Z,1539718436.560 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-10-16T19:33:56.563Z,1539718436.563 [Science:PeakDetectOil] Running Loop=1
2018-10-16T19:33:56.563Z,1539718436.563 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2018-10-16T19:33:56.564Z,1539718436.564 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2018-10-16T19:33:56.564Z,1539718436.564 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-10-16T19:33:56.578Z,1539718436.578 [Science:PeakDetectFDOM] Running Loop=1
2018-10-16T19:33:56.578Z,1539718436.578 [Science:PeakDetectFDOM](DEBUG): Aggregate::initialize Science:PeakDetectFDOM
2018-10-16T19:33:56.578Z,1539718436.578 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2018-10-16T19:33:56.578Z,1539718436.578 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-10-16T19:33:56.585Z,1539718436.585 [Science:PeakDetectFDOM] Stopped
2018-10-16T19:33:56.586Z,1539718436.586 [Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize Science:PeakDetectFDOM
2018-10-16T19:33:56.586Z,1539718436.586 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2018-10-16T19:33:56.586Z,1539718436.586 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-10-16T19:33:56.586Z,1539718436.586 [Science:PeakDetectOil] Stopped
2018-10-16T19:33:56.586Z,1539718436.586 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2018-10-16T19:33:56.587Z,1539718436.587 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2018-10-16T19:33:56.587Z,1539718436.587 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-10-16T19:33:56.587Z,1539718436.587 [Science:PeakDetectNO3] Stopped
2018-10-16T19:33:56.587Z,1539718436.587 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2018-10-16T19:33:56.587Z,1539718436.587 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2018-10-16T19:33:56.587Z,1539718436.587 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-10-16T19:33:56.587Z,1539718436.587 [Science:HighestChlPeakReport] Stopped
2018-10-16T19:33:56.587Z,1539718436.587 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2018-10-16T19:33:56.587Z,1539718436.587 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2018-10-16T19:33:56.587Z,1539718436.587 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2018-10-16T19:33:56.588Z,1539718436.588 [Science:PeakDetectChl] Stopped
2018-10-16T19:33:56.588Z,1539718436.588 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2018-10-16T19:33:56.588Z,1539718436.588 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2018-10-16T19:33:56.588Z,1539718436.588 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-10-16T19:33:56.588Z,1539718436.588 [Science:Read_Oil] Stopped
2018-10-16T19:33:56.588Z,1539718436.588 [Science:H] Stopped
2018-10-16T19:33:56.588Z,1539718436.588 [Science:G] Running Loop=1
2018-10-16T19:33:56.590Z,1539718436.590 [Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2018-10-16T19:33:56.591Z,1539718436.591 [Science:F] Stopped
2018-10-16T19:33:56.591Z,1539718436.591 [Science:E] Stopped
2018-10-16T19:33:56.591Z,1539718436.591 [Science:D] Stopped
2018-10-16T19:33:56.591Z,1539718436.591 [Science:C] Stopped
2018-10-16T19:33:56.591Z,1539718436.591 [Science:B] Stopped
2018-10-16T19:33:56.591Z,1539718436.591 [Science:A] Running Loop=1
2018-10-16T19:33:56.592Z,1539718436.592 [Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2018-10-16T19:33:56.881Z,1539718436.881 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2018-10-16T19:33:56.881Z,1539718436.881 [WetLabsBB2FL](INFO): Powering up
2018-10-16T19:34:00.563Z,1539718440.563 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-10-16T19:34:00.563Z,1539718440.563 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-10-16T19:34:00.563Z,1539718440.563 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-16T19:34:00.584Z,1539718440.584 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-16T19:34:01.090Z,1539718441.090 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-16T19:34:01.090Z,1539718441.090 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-10-16T19:34:01.343Z,1539718441.343 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-16T19:34:01.344Z,1539718441.344 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-16T19:34:01.345Z,1539718441.345 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-16T19:35:03.411Z,1539718503.411 [CommandLine](IMPORTANT): got command report touch Aanderaa_O2.temperature
2018-10-16T19:35:03.808Z,1539718503.808 [Reporter](INFO): Aanderaa_O2.temperature 23.339990 degC
2018-10-16T19:35:04.623Z,1539718504.623 [Reporter](INFO): Aanderaa_O2.temperature 23.342004 degC
2018-10-16T19:35:05.800Z,1539718505.800 [Reporter](INFO): Aanderaa_O2.temperature 23.344995 degC
2018-10-16T19:35:06.997Z,1539718506.997 [Reporter](INFO): Aanderaa_O2.temperature 23.347009 degC
2018-10-16T19:35:07.806Z,1539718507.806 [Reporter](INFO): Aanderaa_O2.temperature 23.350000 degC
2018-10-16T19:35:09.024Z,1539718509.024 [Reporter](INFO): Aanderaa_O2.temperature 23.352014 degC
2018-10-16T19:35:09.806Z,1539718509.806 [Reporter](INFO): Aanderaa_O2.temperature 23.355005 degC
2018-10-16T19:35:11.147Z,1539718511.147 [Reporter](INFO): Aanderaa_O2.temperature 23.357996 degC
2018-10-16T19:35:11.815Z,1539718511.815 [Reporter](INFO): Aanderaa_O2.temperature 23.360010 degC
2018-10-16T19:35:12.737Z,1539718512.737 [CommandLine](IMPORTANT): got command report clear
2018-10-16T19:35:17.253Z,1539718517.253 [CommandLine](IMPORTANT): got command stop
2018-10-16T19:35:17.254Z,1539718517.254 [CommandLine](IMPORTANT): Scheduling is paused
2018-10-16T19:35:17.254Z,1539718517.254 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2018-10-16T19:35:17.379Z,1539718517.379 [MissionManager](INFO): MissionManager is completed.
2018-10-16T19:35:17.380Z,1539718517.380 [MissionManager](INFO): Uninitializing Mission Science
2018-10-16T19:35:17.380Z,1539718517.380 [Science] Stopped
2018-10-16T19:35:17.380Z,1539718517.380 [Science](DEBUG): Aggregate::uninitialize Science
2018-10-16T19:35:17.380Z,1539718517.380 [Science:A] Stopped
2018-10-16T19:35:17.380Z,1539718517.380 [Science:G] Stopped
2018-10-16T19:35:17.641Z,1539718517.641 [WetLabsBB2FL](INFO): Powering down
2018-10-16T19:35:17.792Z,1539718517.792 [MissionManager](IMPORTANT): Started mission Default
2018-10-16T19:35:17.797Z,1539718517.797 [Default] Running Loop=1
2018-10-16T19:35:17.797Z,1539718517.797 [Default](DEBUG): Aggregate::initialize Default
2018-10-16T19:35:17.797Z,1539718517.797 [Default:B.GoToSurface] Running Loop=1
2018-10-16T19:35:17.797Z,1539718517.797 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-10-16T19:35:17.798Z,1539718517.798 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-10-16T19:35:17.798Z,1539718517.798 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-10-16T19:35:17.799Z,1539718517.799 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-10-16T19:35:17.799Z,1539718517.799 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-10-16T19:35:17.800Z,1539718517.800 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-10-16T19:35:17.800Z,1539718517.800 [Default:A.Wait] Running Loop=1
2018-10-16T19:35:17.805Z,1539718517.805 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-10-16T19:35:18.269Z,1539718518.269 [Aanderaa_O2](INFO): Powering down
2018-10-16T19:35:31.014Z,1539718531.014 [Default:A.Wait](INFO): Done Waiting.
2018-10-16T19:35:31.014Z,1539718531.014 [Default:A.Wait] Stopped
2018-10-16T19:35:31.014Z,1539718531.014 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-10-16T19:35:31.363Z,1539718531.363 [Default:CheckIn] Running Loop=1
2018-10-16T19:35:31.363Z,1539718531.363 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-10-16T19:35:31.364Z,1539718531.364 [Default:CheckIn:Read_GPS] Running Loop=1
2018-10-16T19:37:01.551Z,1539718621.551 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-10-16T19:37:01.552Z,1539718621.552 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-10-16T19:37:01.552Z,1539718621.552 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-16T19:37:01.627Z,1539718621.627 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-16T19:37:01.910Z,1539718621.910 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-16T19:37:01.910Z,1539718621.910 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-10-16T19:37:02.311Z,1539718622.311 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-16T19:37:02.311Z,1539718622.311 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-16T19:37:02.312Z,1539718622.312 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-16T19:38:41.859Z,1539718721.859 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-10-16T19:38:41.859Z,1539718721.859 [NAL9602] Data Fault, FailCount= 1
2018-10-16T19:38:41.859Z,1539718721.859 [NAL9602](ERROR): Data Fault
2018-10-16T19:38:41.949Z,1539718721.949 [CBIT](ERROR): Data Fault in component: NAL9602
2018-10-16T19:38:42.262Z,1539718722.262 [NAL9602](INFO): Powering down
2018-10-16T19:38:43.153Z,1539718723.153 [CBIT](INFO): Clearing failed state for component NAL9602
2018-10-16T19:38:43.153Z,1539718723.153 [NAL9602] No Fault, FailCount= 1
2018-10-16T19:39:12.658Z,1539718752.658 [NAL9602](INFO): Powering up NAL9602
2018-10-16T19:39:23.462Z,1539718763.462 [NAL9602](INFO): NAL9602 initialized
2018-10-16T19:40:02.683Z,1539718802.683 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = nan
2018-10-16T19:40:02.683Z,1539718802.683 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-10-16T19:40:02.683Z,1539718802.683 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-10-16T19:40:02.697Z,1539718802.697 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-10-16T19:40:03.107Z,1539718803.107 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-10-16T19:40:03.107Z,1539718803.107 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-10-16T19:40:03.514Z,1539718803.514 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-10-16T19:40:03.515Z,1539718803.515 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-10-16T19:40:03.515Z,1539718803.515 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-10-16T19:40:28.271Z,1539718828.271 [CommandLine](IMPORTANT): got command quit
2018-10-16T19:40:29.280Z,1539718829.280 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-16T19:40:29.280Z,1539718829.280 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:29.353Z,1539718829.353 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-10-16T19:40:29.353Z,1539718829.353 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:29.353Z,1539718829.353 [CommandLine](INFO): Join timeout helper Thread ID is 1290
2018-10-16T19:40:29.354Z,1539718829.354 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-10-16T19:40:29.354Z,1539718829.354 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:29.355Z,1539718829.355 [NavChartDb](INFO): Join timeout helper Thread ID is 1291
2018-10-16T19:40:29.513Z,1539718829.513 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-16T19:40:29.513Z,1539718829.513 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:29.517Z,1539718829.517 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-10-16T19:40:29.517Z,1539718829.517 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:29.518Z,1539718829.518 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1292
2018-10-16T19:40:29.741Z,1539718829.741 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-16T19:40:29.741Z,1539718829.741 [WetLabsBB2FL](INFO): Powering down
2018-10-16T19:40:29.742Z,1539718829.742 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:29.757Z,1539718829.757 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2018-10-16T19:40:29.757Z,1539718829.757 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:29.757Z,1539718829.757 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 1293
2018-10-16T19:40:29.885Z,1539718829.885 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-16T19:40:29.885Z,1539718829.885 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-10-16T19:40:30.024Z,1539718830.024 [Rowe_600LCM](INFO): Powering down
2018-10-16T19:40:30.025Z,1539718830.025 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.037Z,1539718830.037 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-10-16T19:40:30.037Z,1539718830.037 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.037Z,1539718830.037 [Radio_Surface](INFO): Join timeout helper Thread ID is 1295
2018-10-16T19:40:30.361Z,1539718830.361 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-16T19:40:30.361Z,1539718830.361 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.383Z,1539718830.383 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-10-16T19:40:30.383Z,1539718830.383 [logger ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.383Z,1539718830.383 [logger](INFO): Join timeout helper Thread ID is 1296
2018-10-16T19:40:30.383Z,1539718830.383 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-16T19:40:30.384Z,1539718830.384 [logger ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.385Z,1539718830.385 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-10-16T19:40:30.385Z,1539718830.385 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.385Z,1539718830.385 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-10-16T19:40:30.386Z,1539718830.386 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.386Z,1539718830.386 [controlThread](INFO): Join timeout helper Thread ID is 1297
2018-10-16T19:40:30.621Z,1539718830.621 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-10-16T19:40:30.621Z,1539718830.621 [controlThread](DEBUG): Uninitializing ControlThread
2018-10-16T19:40:30.622Z,1539718830.622 [NAL9602](INFO): Powering down
2018-10-16T19:40:30.624Z,1539718830.624 [PNI_TCM](INFO): Powering down
2018-10-16T19:40:30.709Z,1539718830.709 [Aanderaa_O2](INFO): Powering down
2018-10-16T19:40:30.711Z,1539718830.711 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-10-16T19:40:30.712Z,1539718830.712 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-10-16T19:40:30.712Z,1539718830.712 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-10-16T19:40:30.713Z,1539718830.713 [MissionManager](INFO): Uninitializing Mission Default
2018-10-16T19:40:30.713Z,1539718830.713 [Default] Stopped
2018-10-16T19:40:30.713Z,1539718830.713 [Default](DEBUG): Aggregate::uninitialize Default
2018-10-16T19:40:30.713Z,1539718830.713 [Default:B.GoToSurface] Stopped
2018-10-16T19:40:30.713Z,1539718830.713 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-10-16T19:40:30.713Z,1539718830.713 [Default:CheckIn] Stopped
2018-10-16T19:40:30.713Z,1539718830.713 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-10-16T19:40:30.714Z,1539718830.714 [Default:CheckIn:Read_GPS] Stopped
2018-10-16T19:40:30.717Z,1539718830.717 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-10-16T19:40:30.717Z,1539718830.717 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-10-16T19:40:30.717Z,1539718830.717 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-10-16T19:40:30.718Z,1539718830.718 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-10-16T19:40:30.718Z,1539718830.718 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-10-16T19:40:30.718Z,1539718830.718 [BuoyancyServo](INFO): Powering down
2018-10-16T19:40:30.733Z,1539718830.733 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-10-16T19:40:30.733Z,1539718830.733 [ElevatorServo](INFO): Powering down
2018-10-16T19:40:30.734Z,1539718830.734 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-10-16T19:40:30.734Z,1539718830.734 [MassServo](INFO): Powering down
2018-10-16T19:40:30.735Z,1539718830.735 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-10-16T19:40:30.735Z,1539718830.735 [RudderServo](INFO): Powering down
2018-10-16T19:40:30.736Z,1539718830.736 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-10-16T19:40:30.736Z,1539718830.736 [ThrusterServo](INFO): Powering down
2018-10-16T19:40:30.737Z,1539718830.737 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-10-16T19:40:30.737Z,1539718830.737 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-10-16T19:40:30.738Z,1539718830.738 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-10-16T19:40:30.739Z,1539718830.739 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.796Z,1539718830.796 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.803Z,1539718830.803 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.841Z,1539718830.841 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.869Z,1539718830.869 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-10-16T19:40:30.926Z,1539718830.926 [logger ThreadHandler](INFO): Thread cancelled.