2018-09-24T20:19:31.251Z,1537820371.251 [Supervisor](DEBUG): Initializing supervisor.
2018-09-24T20:19:31.254Z,1537820371.254 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-09-24T20:19:31.254Z,1537820371.254 [SyncHandler](INFO): Protected caller Thread ID is 2925
2018-09-24T20:19:31.255Z,1537820371.255 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-09-24T20:19:31.256Z,1537820371.256 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-09-24T20:19:31.256Z,1537820371.256 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2926
2018-09-24T20:19:31.259Z,1537820371.259 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-09-24T20:19:31.270Z,1537820371.270 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-09-24T20:19:31.271Z,1537820371.271 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-09-24T20:19:31.272Z,1537820371.272 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2927
2018-09-24T20:19:31.273Z,1537820371.273 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-09-24T20:19:31.274Z,1537820371.274 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-09-24T20:19:31.274Z,1537820371.274 [logger ThreadHandler](INFO): Protected caller Thread ID is 2928
2018-09-24T20:19:31.276Z,1537820371.276 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-09-24T20:19:31.276Z,1537820371.276 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-09-24T20:19:31.278Z,1537820371.278 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-09-24T20:19:31.466Z,1537820371.466 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-09-24T20:19:31.466Z,1537820371.466 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-09-24T20:19:31.609Z,1537820371.609 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-09-24T20:19:31.610Z,1537820371.610 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-09-24T20:19:31.955Z,1537820371.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-09-24T20:19:31.956Z,1537820371.956 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-09-24T20:19:32.094Z,1537820372.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-09-24T20:19:32.094Z,1537820372.094 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-09-24T20:19:32.175Z,1537820372.175 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-09-24T20:19:32.378Z,1537820372.378 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-09-24T20:19:32.378Z,1537820372.378 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-09-24T20:19:32.482Z,1537820372.482 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-09-24T20:19:32.483Z,1537820372.483 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-09-24T20:19:32.944Z,1537820372.944 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-09-24T20:19:32.945Z,1537820372.945 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-09-24T20:19:33.415Z,1537820373.415 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-09-24T20:19:33.416Z,1537820373.416 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-09-24T20:19:33.845Z,1537820373.845 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-09-24T20:19:33.845Z,1537820373.845 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-09-24T20:19:34.362Z,1537820374.362 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-09-24T20:19:34.363Z,1537820374.363 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-09-24T20:19:34.569Z,1537820374.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-09-24T20:19:34.570Z,1537820374.570 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-09-24T20:19:34.668Z,1537820374.668 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-09-24T20:19:34.669Z,1537820374.669 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-09-24T20:19:35.158Z,1537820375.158 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-09-24T20:19:35.158Z,1537820375.158 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-09-24T20:19:35.265Z,1537820375.265 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-09-24T20:19:35.267Z,1537820375.267 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2018-09-24T20:19:35.268Z,1537820375.268 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2018-09-24T20:19:35.496Z,1537820375.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-09-24T20:19:35.497Z,1537820375.497 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2018-09-24T20:19:35.595Z,1537820375.595 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2018-09-24T20:19:35.688Z,1537820375.688 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2018-09-24T20:19:35.791Z,1537820375.791 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2018-09-24T20:19:35.877Z,1537820375.877 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2018-09-24T20:19:36.011Z,1537820376.011 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2018-09-24T20:19:36.180Z,1537820376.180 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2018-09-24T20:19:36.290Z,1537820376.290 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2018-09-24T20:19:36.375Z,1537820376.375 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2018-09-24T20:19:36.458Z,1537820376.458 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2018-09-24T20:19:36.649Z,1537820376.649 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-09-24T20:19:36.663Z,1537820376.663 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-09-24T20:19:36.789Z,1537820376.789 [SBIT](DEBUG): Construct Startup Built In Test.
2018-09-24T20:19:36.819Z,1537820376.819 [SBIT] Loaded
2018-09-24T20:19:36.819Z,1537820376.819 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-09-24T20:19:36.820Z,1537820376.820 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-09-24T20:19:36.847Z,1537820376.847 [IBIT] Loaded
2018-09-24T20:19:36.847Z,1537820376.847 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-09-24T20:19:36.850Z,1537820376.850 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-09-24T20:19:37.005Z,1537820377.005 [CBIT] Loaded
2018-09-24T20:19:37.005Z,1537820377.005 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-09-24T20:19:37.005Z,1537820377.005 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-09-24T20:19:37.006Z,1537820377.006 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-09-24T20:19:37.071Z,1537820377.071 [VerticalControl](DEBUG): Construct VerticalControl.
2018-09-24T20:19:37.171Z,1537820377.171 [VerticalControl] Loaded
2018-09-24T20:19:37.172Z,1537820377.172 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-09-24T20:19:37.173Z,1537820377.173 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-09-24T20:19:37.233Z,1537820377.233 [HorizontalControl] Loaded
2018-09-24T20:19:37.233Z,1537820377.233 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-09-24T20:19:37.234Z,1537820377.234 [SpeedControl](DEBUG): Construct SpeedControl.
2018-09-24T20:19:37.239Z,1537820377.239 [SpeedControl] Loaded
2018-09-24T20:19:37.239Z,1537820377.239 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-09-24T20:19:37.240Z,1537820377.240 [LoopControl](DEBUG): Construct LoopControl.
2018-09-24T20:19:37.240Z,1537820377.240 [LoopControl] Loaded
2018-09-24T20:19:37.241Z,1537820377.241 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-09-24T20:19:37.241Z,1537820377.241 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-09-24T20:19:37.242Z,1537820377.242 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-09-24T20:19:37.282Z,1537820377.282 [DepthRateCalculator] Loaded
2018-09-24T20:19:37.282Z,1537820377.282 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-09-24T20:19:37.288Z,1537820377.288 [PitchRateCalculator] Loaded
2018-09-24T20:19:37.288Z,1537820377.288 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-09-24T20:19:37.304Z,1537820377.304 [SpeedCalculator] Loaded
2018-09-24T20:19:37.304Z,1537820377.304 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-09-24T20:19:37.325Z,1537820377.325 [TempGradientCalculator] Loaded
2018-09-24T20:19:37.325Z,1537820377.325 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-09-24T20:19:37.331Z,1537820377.331 [YawRateCalculator] Loaded
2018-09-24T20:19:37.331Z,1537820377.331 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-09-24T20:19:37.360Z,1537820377.360 [ElevatorOffsetCalculator] Loaded
2018-09-24T20:19:37.360Z,1537820377.360 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-09-24T20:19:37.361Z,1537820377.361 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-09-24T20:19:37.361Z,1537820377.361 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-09-24T20:19:37.424Z,1537820377.424 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-09-24T20:19:37.425Z,1537820377.425 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-09-24T20:19:37.742Z,1537820377.742 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-09-24T20:19:37.743Z,1537820377.743 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-09-24T20:19:37.838Z,1537820377.838 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-09-24T20:19:37.839Z,1537820377.839 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-09-24T20:19:37.892Z,1537820377.892 [DeadReckonUsingSpeedCalculator] Loaded
2018-09-24T20:19:37.893Z,1537820377.893 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-09-24T20:19:37.909Z,1537820377.909 [NavChart] Loaded
2018-09-24T20:19:37.909Z,1537820377.909 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-09-24T20:19:37.914Z,1537820377.914 [UniversalFixResidualReporter] Loaded
2018-09-24T20:19:37.914Z,1537820377.914 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-09-24T20:19:37.914Z,1537820377.914 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-09-24T20:19:37.915Z,1537820377.915 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-09-24T20:19:37.928Z,1537820377.928 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-09-24T20:19:37.928Z,1537820377.928 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-09-24T20:19:46.167Z,1537820386.167 [CTD_NeilBrown] Loaded
2018-09-24T20:19:46.167Z,1537820386.167 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2018-09-24T20:19:46.168Z,1537820386.168 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406DB4E0
2018-09-24T20:19:46.169Z,1537820386.169 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 3007
2018-09-24T20:19:46.213Z,1537820386.213 [WetLabsSeaOWL_UV_A] Loaded
2018-09-24T20:19:46.214Z,1537820386.214 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2018-09-24T20:19:46.215Z,1537820386.215 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 4070B4E0
2018-09-24T20:19:46.215Z,1537820386.215 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 3008
2018-09-24T20:19:46.216Z,1537820386.216 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-09-24T20:19:46.216Z,1537820386.216 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-09-24T20:19:46.513Z,1537820386.513 [AHRS_M2] Loaded
2018-09-24T20:19:46.513Z,1537820386.513 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-09-24T20:19:46.582Z,1537820386.582 [DataOverHttps] Loaded
2018-09-24T20:19:46.582Z,1537820386.582 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-09-24T20:19:46.595Z,1537820386.595 [Depth_Keller] Loaded
2018-09-24T20:19:46.596Z,1537820386.596 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-09-24T20:19:46.601Z,1537820386.601 [DropWeight] Loaded
2018-09-24T20:19:46.601Z,1537820386.601 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-09-24T20:19:46.691Z,1537820386.691 [NAL9602] Loaded
2018-09-24T20:19:46.691Z,1537820386.691 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-09-24T20:19:46.696Z,1537820386.696 [Onboard] Loaded
2018-09-24T20:19:46.696Z,1537820386.696 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-09-24T20:19:46.704Z,1537820386.704 [Radio_Surface] Loaded
2018-09-24T20:19:46.704Z,1537820386.704 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-09-24T20:19:46.705Z,1537820386.705 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096C4E0
2018-09-24T20:19:46.706Z,1537820386.706 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3009
2018-09-24T20:19:46.734Z,1537820386.734 [RDI_Pathfinder] Loaded
2018-09-24T20:19:46.734Z,1537820386.734 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2018-09-24T20:19:46.740Z,1537820386.740 [SCPI] Loaded
2018-09-24T20:19:46.741Z,1537820386.741 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2018-09-24T20:19:48.616Z,1537820388.616 [BPC1] Loaded
2018-09-24T20:19:48.616Z,1537820388.616 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-09-24T20:19:48.616Z,1537820388.616 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-09-24T20:19:48.617Z,1537820388.617 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-09-24T20:19:48.713Z,1537820388.713 [BuoyancyServo] Loaded
2018-09-24T20:19:48.714Z,1537820388.714 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-09-24T20:19:48.725Z,1537820388.725 [ElevatorServo] Loaded
2018-09-24T20:19:48.726Z,1537820388.726 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-09-24T20:19:48.737Z,1537820388.737 [MassServo] Loaded
2018-09-24T20:19:48.737Z,1537820388.737 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-09-24T20:19:48.748Z,1537820388.748 [RudderServo] Loaded
2018-09-24T20:19:48.749Z,1537820388.749 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-09-24T20:19:48.760Z,1537820388.760 [ThrusterServo] Loaded
2018-09-24T20:19:48.760Z,1537820388.760 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-09-24T20:19:48.760Z,1537820388.760 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-09-24T20:19:48.761Z,1537820388.761 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-09-24T20:19:48.859Z,1537820388.859 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-09-24T20:19:48.859Z,1537820388.859 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-09-24T20:19:48.883Z,1537820388.883 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-09-24T20:19:48.887Z,1537820388.887 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-09-24T20:19:48.887Z,1537820388.887 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-09-24T20:19:48.894Z,1537820388.894 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-09-24T20:19:48.895Z,1537820388.895 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A154E0
2018-09-24T20:19:48.896Z,1537820388.896 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3010
2018-09-24T20:19:48.900Z,1537820388.900 [Supervisor](INFO): Main Thread ID is 795
2018-09-24T20:19:48.900Z,1537820388.900 [Supervisor](DEBUG): Running supervisor.
2018-09-24T20:19:48.901Z,1537820388.901 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3011
2018-09-24T20:19:48.903Z,1537820388.903 [controlThread ThreadHandler](INFO): Handler Thread ID is 3012
2018-09-24T20:19:48.903Z,1537820388.903 [controlThread](DEBUG): Initializing ControlThread
2018-09-24T20:19:48.904Z,1537820388.904 [SBIT](INFO): Initialize SBIT Component.
2018-09-24T20:19:48.905Z,1537820388.905 [SBIT](IMPORTANT): git: 2018-09-20
2018-09-24T20:19:48.905Z,1537820388.905 [SBIT](INFO): git hash: cc82e4f04ca47b19cdcc10b5d3e1760510b3ba6f
2018-09-24T20:19:48.906Z,1537820388.906 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-09-24T20:19:48.906Z,1537820388.906 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-09-24T20:19:48.907Z,1537820388.907 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2018-09-24T20:19:48.907Z,1537820388.907 [IBIT](INFO): Initialize IBIT Component.
2018-09-24T20:19:48.908Z,1537820388.908 [CBIT](DEBUG): Initialize CBIT Component.
2018-09-24T20:19:48.909Z,1537820388.909 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-09-24T20:19:48.910Z,1537820388.910 [logger ThreadHandler](INFO): Handler Thread ID is 3013
2018-09-24T20:19:48.937Z,1537820388.937 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 3014
2018-09-24T20:19:48.957Z,1537820388.957 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 3015
2018-09-24T20:19:48.958Z,1537820388.958 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-24T20:19:48.981Z,1537820388.981 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3016
2018-09-24T20:19:48.987Z,1537820388.987 [Radio_Surface](INFO): Powering up
2018-09-24T20:19:49.004Z,1537820389.004 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3017
2018-09-24T20:19:49.007Z,1537820389.007 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-09-24T20:19:49.007Z,1537820389.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-09-24T20:19:49.007Z,1537820389.007 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-09-24T20:19:49.007Z,1537820389.007 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-09-24T20:19:49.008Z,1537820389.008 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-09-24T20:19:49.008Z,1537820389.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-09-24T20:19:49.008Z,1537820389.008 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-09-24T20:19:49.008Z,1537820389.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-09-24T20:19:49.008Z,1537820389.008 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-09-24T20:19:49.008Z,1537820389.008 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-09-24T20:19:49.009Z,1537820389.009 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-09-24T20:19:49.009Z,1537820389.009 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-09-24T20:19:49.009Z,1537820389.009 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-09-24T20:19:49.009Z,1537820389.009 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-09-24T20:19:49.010Z,1537820389.010 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-09-24T20:19:49.010Z,1537820389.010 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-09-24T20:19:49.017Z,1537820389.017 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-09-24T20:19:49.019Z,1537820389.019 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-09-24T20:19:49.020Z,1537820389.020 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-09-24T20:19:49.020Z,1537820389.020 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-09-24T20:19:49.021Z,1537820389.021 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-24T20:19:49.021Z,1537820389.021 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-09-24T20:19:49.021Z,1537820389.021 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-09-24T20:19:49.022Z,1537820389.022 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-09-24T20:19:49.022Z,1537820389.022 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-09-24T20:19:49.023Z,1537820389.023 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-09-24T20:19:49.023Z,1537820389.023 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-09-24T20:19:49.024Z,1537820389.024 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-09-24T20:19:49.025Z,1537820389.025 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-09-24T20:19:49.025Z,1537820389.025 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-09-24T20:19:49.026Z,1537820389.026 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-09-24T20:19:49.026Z,1537820389.026 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-09-24T20:19:49.026Z,1537820389.026 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-09-24T20:19:49.027Z,1537820389.027 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-09-24T20:19:49.034Z,1537820389.034 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-09-24T20:19:49.066Z,1537820389.066 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-24T20:19:49.101Z,1537820389.101 [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-09-24T20:19:49.102Z,1537820389.102 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-09-24T20:19:49.181Z,1537820389.181 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-09-24T20:19:49.182Z,1537820389.182 [Default:A.Wait](DEBUG): Construct Wait.
2018-09-24T20:19:49.184Z,1537820389.184 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-09-24T20:19:49.232Z,1537820389.232 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-09-24T20:19:49.235Z,1537820389.235 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-09-24T20:19:49.269Z,1537820389.269 [Default:E.Execute](DEBUG): Construct Execute.
2018-09-24T20:19:49.272Z,1537820389.272 [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-09-24T20:19:49.297Z,1537820389.297 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-09-24T20:19:49.321Z,1537820389.321 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-09-24T20:19:49.372Z,1537820389.372 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-09-24T20:19:49.414Z,1537820389.414 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2018-09-24T20:19:49.581Z,1537820389.581 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-09-24T20:19:49.662Z,1537820389.662 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:49.691Z,1537820389.691 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:49.801Z,1537820389.801 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-09-24T20:19:49.809Z,1537820389.809 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-09-24T20:19:49.843Z,1537820389.843 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-09-24T20:19:49.849Z,1537820389.849 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-09-24T20:19:49.855Z,1537820389.855 [MassServo](DEBUG): Initializing EZServoServo.
2018-09-24T20:19:49.861Z,1537820389.861 [MassServo](DEBUG): Initializing MassServo.
2018-09-24T20:19:49.875Z,1537820389.875 [RudderServo](DEBUG): Initializing EZServoServo.
2018-09-24T20:19:49.881Z,1537820389.881 [RudderServo](DEBUG): Initializing RudderServo.
2018-09-24T20:19:49.901Z,1537820389.901 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-09-24T20:19:49.909Z,1537820389.909 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-09-24T20:19:50.065Z,1537820390.065 [DepthRateCalculator](ERROR): Depth measurement is not active
2018-09-24T20:19:50.068Z,1537820390.068 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:50.077Z,1537820390.077 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:50.416Z,1537820390.416 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:50.425Z,1537820390.425 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:50.765Z,1537820390.765 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2018-09-24T20:19:50.765Z,1537820390.765 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2018-09-24T20:19:50.765Z,1537820390.765 [BuoyancyServo] Communications Fault, FailCount= 1
2018-09-24T20:19:50.765Z,1537820390.765 [BuoyancyServo](ERROR): Communications Fault
2018-09-24T20:19:50.977Z,1537820390.977 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2018-09-24T20:19:51.037Z,1537820391.037 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:51.039Z,1537820391.039 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:51.045Z,1537820391.045 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-09-24T20:19:51.046Z,1537820391.046 [BuoyancyServo](INFO): Powering down
2018-09-24T20:19:51.416Z,1537820391.416 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:51.417Z,1537820391.417 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:51.817Z,1537820391.817 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:51.818Z,1537820391.818 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:52.212Z,1537820392.212 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:52.214Z,1537820392.214 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:52.653Z,1537820392.653 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:52.654Z,1537820392.654 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-09-24T20:19:53.114Z,1537820393.114 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2018-09-24T20:19:53.115Z,1537820393.115 [BuoyancyServo] No Fault, FailCount= 1
2018-09-24T20:19:53.455Z,1537820393.455 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-09-24T20:19:53.574Z,1537820393.574 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-09-24T20:20:02.819Z,1537820402.819 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2018-09-24T20:20:09.637Z,1537820409.637 [SBIT](IMPORTANT): Beginning Startup BIT
2018-09-24T20:20:09.648Z,1537820409.648 [CBIT](IMPORTANT): Beginning ground fault scan
2018-09-24T20:20:16.907Z,1537820416.907 [NAL9602](INFO): Powering up NAL9602
2018-09-24T20:20:20.583Z,1537820420.583 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.024750
CHAN A1 (24V): -0.028013
CHAN A2 (12V): -0.006973
CHAN A3 (5V): -0.001786
CHAN B0 (3.3V): 0.000263
CHAN B1 (3.15aV): 0.000114
CHAN B2 (3.15bV): 0.000607
CHAN B3 (GND): 0.002166
OPEN: 0.005192
Full Scale Calc: 4.765 mA, -1.589 mA
2018-09-24T20:20:27.911Z,1537820427.911 [NAL9602](INFO): NAL9602 initialized
2018-09-24T20:20:52.450Z,1537820452.450 [NAL9602](INFO): SBD MO Status=2, MOMSN=1610, MT Status=2, MTMSN=0
2018-09-24T20:20:52.450Z,1537820452.450 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-09-24T20:20:54.070Z,1537820454.070 [RDI_Pathfinder](ERROR): Failed to parse:     +0.00,        +0.00,        +0.00,   0.00, 51.00
2018-09-24T20:21:03.715Z,1537820463.715 [SBIT](IMPORTANT): SBIT PASSED
2018-09-24T20:21:03.759Z,1537820463.759 [CommandLine](IMPORTANT): got command configSet list
2018-09-24T20:21:03.759Z,1537820463.759 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-09-24T20:21:03.760Z,1537820463.760 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;

2018-09-24T20:21:03.760Z,1537820463.760 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=1 hour;

2018-09-24T20:21:03.760Z,1537820463.760 [CommandLine](IMPORTANT): BuoyancyServo.accel=400 none;

2018-09-24T20:21:03.760Z,1537820463.760 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpCoefficient=1 none;

2018-09-24T20:21:03.761Z,1537820463.761 [CommandLine](IMPORTANT): BuoyancyServo.velocity=300 none;

2018-09-24T20:21:03.761Z,1537820463.761 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=1 bool;

2018-09-24T20:21:03.761Z,1537820463.761 [CommandLine](IMPORTANT): CTD_NeilBrown.simulateHardware=1 bool;

2018-09-24T20:21:03.761Z,1537820463.761 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 5.000000 meter;

2018-09-24T20:21:03.761Z,1537820463.761 [CommandLine](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_chlorophyll_in_sea_water 0.500000 microgram_per_liter;

2018-09-24T20:21:03.761Z,1537820463.761 [CommandLine](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2018-09-24T20:21:03.762Z,1537820463.762 [CommandLine](IMPORTANT): IBIT.batteryVoltageThreshold=13.7 volt;

2018-09-24T20:21:03.762Z,1537820463.762 [CommandLine](IMPORTANT): RDI_PathfinderUp.loadAtStartup=0 bool;

2018-09-24T20:21:03.762Z,1537820463.762 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=205 cubic_centimeter;

2018-09-24T20:21:03.762Z,1537820463.762 [CommandLine](IMPORTANT): VerticalControl.massDefault=0 millimeter;

2018-09-24T20:21:03.762Z,1537820463.762 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;

2018-09-24T20:21:03.762Z,1537820463.762 [CommandLine](IMPORTANT): WetLabsBB2FL.simulateHardware=0 bool;

2018-09-24T20:21:04.106Z,1537820464.106 [MissionManager](IMPORTANT): Started mission Startup
2018-09-24T20:21:04.106Z,1537820464.106 [Startup] Running Loop=1
2018-09-24T20:21:04.106Z,1537820464.106 [Startup](DEBUG): Aggregate::initialize Startup
2018-09-24T20:21:04.106Z,1537820464.106 [Startup:A.GoToSurface] Running Loop=1
2018-09-24T20:21:04.106Z,1537820464.106 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-24T20:21:04.107Z,1537820464.107 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-24T20:21:04.107Z,1537820464.107 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-24T20:21:04.108Z,1537820464.108 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-24T20:21:04.108Z,1537820464.108 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-24T20:21:04.108Z,1537820464.108 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-24T20:21:04.116Z,1537820464.116 [Startup:StartupSatComms] Running Loop=1
2018-09-24T20:21:04.117Z,1537820464.117 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-09-24T20:21:04.121Z,1537820464.121 [Startup:StartupSatComms:A] Running Loop=1
2018-09-24T20:21:04.485Z,1537820464.485 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-09-24T20:21:09.644Z,1537820469.644 [NAL9602](INFO): SBD MO Status=2, MOMSN=1610, MT Status=2, MTMSN=0
2018-09-24T20:21:09.644Z,1537820469.644 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-09-24T20:21:34.075Z,1537820494.075 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2018-09-24T20:21:34.076Z,1537820494.076 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,18092413271109,35.0, -0.1,  8.9I,-32768,-32768,-32768,-32768,V
2018-09-24T20:21:39.644Z,1537820499.644 [NAL9602](INFO): SBD MO Status=2, MOMSN=1610, MT Status=2, MTMSN=0
2018-09-24T20:21:39.644Z,1537820499.644 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-09-24T20:21:56.844Z,1537820516.844 [NAL9602](INFO): SBD MO Status=2, MOMSN=1610, MT Status=2, MTMSN=0
2018-09-24T20:21:56.844Z,1537820516.844 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-09-24T20:22:04.135Z,1537820524.135 [Startup:StartupSatComms:A](INFO): Timed out from 2018-09-24T20:21:04.1Z
2018-09-24T20:22:04.135Z,1537820524.135 [Startup:StartupSatComms:A] Stopped
2018-09-24T20:22:04.135Z,1537820524.135 [Startup:StartupSatComms:B] Running Loop=1
2018-09-24T20:22:04.501Z,1537820524.501 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-09-24T20:22:15.245Z,1537820535.245 [NAL9602](INFO): SBD MO Status=0, MOMSN=1610, MT Status=0, MTMSN=0
2018-09-24T20:22:15.245Z,1537820535.245 [NAL9602](INFO): No messages in MT queue
2018-09-24T20:22:16.444Z,1537820536.444 [NAL9602](INFO): GPS fix at 20180924T202207: (36.850981, -121.915604)
2018-09-24T20:22:26.148Z,1537820546.148 [NAL9602](INFO): SBD MO Status=1, MOMSN=1611, MT Status=0, MTMSN=0
2018-09-24T20:22:26.210Z,1537820546.210 [NAL9602](INFO): Sent 25 bytes from file Logs/20180924T174057/Courier0051.lzma
2018-09-24T20:22:26.210Z,1537820546.210 [NAL9602](INFO): Packets left to send: 0
2018-09-24T20:22:26.212Z,1537820546.212 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180924T174057/Courier0051.lzma.parts/0000.sbd
2018-09-24T20:22:26.212Z,1537820546.212 [NAL9602](DEBUG): Completed sending Logs/20180924T174057/Courier0051.lzma
2018-09-24T20:22:47.488Z,1537820567.488 [NAL9602](INFO): SBD MO Status=1, MOMSN=1612, MT Status=0, MTMSN=0
2018-09-24T20:22:47.551Z,1537820567.551 [NAL9602](INFO): Sent 332 bytes from file Logs/20180924T174057/Express0052.lzma
2018-09-24T20:22:47.551Z,1537820567.551 [NAL9602](INFO): Packets left to send: 9
2018-09-24T20:22:47.553Z,1537820567.553 [NAL9602](DEBUG): Stored copy of sent data in Logs/20180924T174057/Express0052.lzma.parts/0009.sbd
2018-09-24T20:23:04.449Z,1537820584.449 [Startup:StartupSatComms:B](INFO): Timed out from 2018-09-24T20:22:04.1Z
2018-09-24T20:23:04.449Z,1537820584.449 [Startup:StartupSatComms:B] Stopped
2018-09-24T20:23:04.449Z,1537820584.449 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-09-24T20:23:04.449Z,1537820584.449 [Startup:StartupSatComms] Stopped
2018-09-24T20:23:04.449Z,1537820584.449 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-09-24T20:23:04.450Z,1537820584.450 [Startup](INFO): Completed Startup
2018-09-24T20:23:04.451Z,1537820584.451 [MissionManager](INFO): Startup is completed.
2018-09-24T20:23:04.451Z,1537820584.451 [MissionManager](INFO): Uninitializing Mission Startup
2018-09-24T20:23:04.451Z,1537820584.451 [Startup] Stopped
2018-09-24T20:23:04.451Z,1537820584.451 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-09-24T20:23:04.451Z,1537820584.451 [Startup:A.GoToSurface] Stopped
2018-09-24T20:23:04.451Z,1537820584.451 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-24T20:23:04.864Z,1537820584.864 [MissionManager](IMPORTANT): Started mission Default
2018-09-24T20:23:04.864Z,1537820584.864 [Default] Running Loop=1
2018-09-24T20:23:04.869Z,1537820584.869 [Default](DEBUG): Aggregate::initialize Default
2018-09-24T20:23:04.869Z,1537820584.869 [Default:B.GoToSurface] Running Loop=1
2018-09-24T20:23:04.869Z,1537820584.869 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-24T20:23:04.869Z,1537820584.869 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-24T20:23:04.870Z,1537820584.870 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-24T20:23:04.870Z,1537820584.870 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-24T20:23:04.870Z,1537820584.870 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-24T20:23:04.871Z,1537820584.871 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-24T20:23:04.871Z,1537820584.871 [Default:A.Wait] Running Loop=1
2018-09-24T20:23:04.871Z,1537820584.871 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-09-24T20:23:06.004Z,1537820586.004 [NAL9602](INFO): SBD MO Status=2, MOMSN=1613, MT Status=2, MTMSN=0
2018-09-24T20:23:06.004Z,1537820586.004 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2018-09-24T20:23:17.021Z,1537820597.021 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004220
2018-09-24T20:23:18.266Z,1537820598.266 [Default:A.Wait](INFO): Done Waiting.
2018-09-24T20:23:18.267Z,1537820598.267 [Default:A.Wait] Stopped
2018-09-24T20:23:18.267Z,1537820598.267 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-09-24T20:23:18.668Z,1537820598.668 [Default:CheckIn] Running Loop=1
2018-09-24T20:23:18.668Z,1537820598.668 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-24T20:23:18.669Z,1537820598.669 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-24T20:23:19.089Z,1537820599.089 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-09-24T20:23:20.631Z,1537820600.631 [NAL9602](INFO): GPS fix at 20180924T202311: (36.851005, -121.915576)
2018-09-24T20:23:20.687Z,1537820600.687 [Default:CheckIn:Read_GPS] Stopped
2018-09-24T20:23:20.687Z,1537820600.687 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-24T20:23:21.102Z,1537820601.102 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-09-24T20:23:26.236Z,1537820606.236 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20180924T201931/Courier0004.lzma
2018-09-24T20:23:27.433Z,1537820607.433 [DataOverHttps](INFO): Moved sent file to Logs/20180924T201931/Courier0004.lzma.bak
2018-09-24T20:23:27.433Z,1537820607.433 [DataOverHttps](INFO): SBD MOMSN=8575167
2018-09-24T20:23:37.900Z,1537820617.900 [DataOverHttps](INFO): Sending 2999 bytes from file Logs/20180924T174057/Express0052.lzma
2018-09-24T20:23:39.038Z,1537820619.038 [DataOverHttps](INFO): Moved sent file to Logs/20180924T174057/Express0052.lzma.bak
2018-09-24T20:23:39.038Z,1537820619.038 [DataOverHttps](INFO): SBD MOMSN=8575172
2018-09-24T20:23:48.597Z,1537820628.597 [DataOverHttps](INFO): Sending 1107 bytes from file Logs/20180924T201931/Express0001.lzma
2018-09-24T20:23:49.361Z,1537820629.361 [DataOverHttps](INFO): Moved sent file to Logs/20180924T201931/Express0001.lzma.bak
2018-09-24T20:23:49.361Z,1537820629.361 [DataOverHttps](INFO): SBD MOMSN=8575302
2018-09-24T20:23:55.634Z,1537820635.634 [NAL9602](INFO): Powering down
2018-09-24T20:24:02.092Z,1537820642.092 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20180924T201931/Express0005.lzma
2018-09-24T20:24:02.824Z,1537820642.824 [DataOverHttps](INFO): Moved sent file to Logs/20180924T201931/Express0005.lzma.bak
2018-09-24T20:24:02.824Z,1537820642.824 [DataOverHttps](INFO): SBD MOMSN=8575332
2018-09-24T20:24:03.396Z,1537820643.396 [Default:CheckIn:Read_Iridium] Stopped
2018-09-24T20:24:03.396Z,1537820643.396 [Default:CheckIn:C.Wait] Running Loop=1
2018-09-24T20:24:03.396Z,1537820643.396 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2018-09-24T20:24:49.758Z,1537820689.758 [CommandLine](IMPORTANT): got command show variable sea_water_temperature
2018-09-24T20:24:49.768Z,1537820689.768 [CommandLine](IMPORTANT): sea_water_temperature (unknown)
2018-09-24T20:24:49.768Z,1537820689.768 [CommandLine](IMPORTANT): upward_derivative_of_sea_water_temperature (unknown)
2018-09-24T20:24:49.907Z,1537820689.907 [CommandLine](IMPORTANT): TempGradientCalculator.upward_derivative_of_sea_water_temperature (celsius_per_meter)
2018-09-24T20:24:49.914Z,1537820689.914 [CommandLine](IMPORTANT): CTD_NeilBrown.sea_water_temperature (celsius)
2018-09-24T20:24:49.915Z,1537820689.915 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_median_sea_water_temperature (celsius)
2018-09-24T20:24:49.915Z,1537820689.915 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_mean_sea_water_temperature (celsius)
2018-09-24T20:24:49.916Z,1537820689.916 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_standard_deviation_sea_water_temperature (celsius)
2018-09-24T20:24:57.208Z,1537820697.208 [CommandLine](IMPORTANT): got command get CTD_NeilBrown.sea_water_temperature
2018-09-24T20:24:57.209Z,1537820697.209 [CommandLine](IMPORTANT): CTD_NeilBrown.sea_water_temperature nan degC
2018-09-24T20:25:03.409Z,1537820703.409 [CommandLine](IMPORTANT): got command get sea_water_temperature
2018-09-24T20:25:03.409Z,1537820703.409 [CommandLine](FAULT): Element has no value
2018-09-24T20:25:27.452Z,1537820727.452 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science_yz.xml
2018-09-24T20:25:27.452Z,1537820727.452 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science_yz.xml
2018-09-24T20:25:27.645Z,1537820727.645 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2018-09-24T20:25:27.648Z,1537820727.648 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2018-09-24T20:25:27.652Z,1537820727.652 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2018-09-24T20:25:27.655Z,1537820727.655 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2018-09-24T20:25:27.660Z,1537820727.660 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2018-09-24T20:25:27.688Z,1537820727.688 [MissionManager](INFO): DefineArg Science.PatchTracking = 1 bool
2018-09-24T20:25:27.708Z,1537820727.708 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2018-09-24T20:25:27.711Z,1537820727.711 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2018-09-24T20:25:27.715Z,1537820727.715 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2018-09-24T20:25:27.790Z,1537820727.790 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2018-09-24T20:25:27.801Z,1537820727.801 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2018-09-24T20:25:27.804Z,1537820727.804 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2018-09-24T20:25:27.839Z,1537820727.839 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 bool
2018-09-24T20:25:27.847Z,1537820727.847 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 bool
2018-09-24T20:25:27.860Z,1537820727.860 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 0.000000 bool
2018-09-24T20:25:27.876Z,1537820727.876 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2018-09-24T20:25:27.888Z,1537820727.888 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 0.000000 bool
2018-09-24T20:25:27.909Z,1537820727.909 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 1.000000 bool
2018-09-24T20:25:27.917Z,1537820727.917 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2018-09-24T20:25:27.920Z,1537820727.920 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2018-09-24T20:25:27.936Z,1537820727.936 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = 10.000000 m
2018-09-24T20:25:27.944Z,1537820727.944 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = 20.000000 m
2018-09-24T20:25:27.948Z,1537820727.948 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2018-09-24T20:25:27.967Z,1537820727.967 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2018-09-24T20:25:27.971Z,1537820727.971 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2018-09-24T20:25:27.983Z,1537820727.983 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2018-09-24T20:25:27.995Z,1537820727.995 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2018-09-24T20:25:27.999Z,1537820727.999 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2018-09-24T20:25:28.028Z,1537820728.028 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2018-09-24T20:25:28.035Z,1537820728.035 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2018-09-24T20:25:28.039Z,1537820728.039 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2018-09-24T20:25:28.051Z,1537820728.051 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2018-09-24T20:25:28.056Z,1537820728.056 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2018-09-24T20:25:28.067Z,1537820728.067 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2018-09-24T20:25:28.072Z,1537820728.072 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2018-09-24T20:25:28.086Z,1537820728.086 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2018-09-24T20:25:28.105Z,1537820728.105 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2018-09-24T20:25:28.109Z,1537820728.109 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2018-09-24T20:25:28.112Z,1537820728.112 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2018-09-24T20:25:28.203Z,1537820728.203 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2018-09-24T20:25:28.253Z,1537820728.253 [Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-09-24T20:25:28.294Z,1537820728.294 [Science:HighestChlPeakReport:B.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2018-09-24T20:25:28.349Z,1537820728.349 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-09-24T20:25:28.374Z,1537820728.374 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2018-09-24T20:25:28.453Z,1537820728.453 [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="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
<!--debug
    </Description><False/></DefineArg>
-->
    </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="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="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.
<!--debug
    </Description><Units:meter/><Value>NaN</Value></DefineArg>
-->
    </Description><Units:meter/><Value>10</Value></DefineArg>

    <DefineArg Name="PeakChlDeepBound"><Description>
        Deep depth bound for detecting chl peak on each descent or ascent
        profile.
<!--debug
    </Description><Units:meter/><Value>NaN</Value></DefineArg>
-->
    </Description><Units:meter/><Value>20</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>

    <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>

<!--debug-->
    <ReadData Id="Read_Oil" Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsSeaOWL_UV_A"/>
            <Or>
                <Arg Name="PeakDetectOilActive"/>
            </Or>
            <Or>
                <Arg Name="PeakDetectChlActive"/>
            </Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>
        
        <Syslog Severity="Important">Calling peak detect vs depth</Syslog>

        <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="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>

        <Syslog Severity="Important">Calling peak detect horizontal</Syslog>        

        <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>
            <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.windowLength/><Arg Name="LowPassWindowLength"/></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>


2018-09-24T20:25:28.459Z,1537820728.459 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science_yz.xml
2018-09-24T20:25:28.460Z,1537820728.460 [CommandLine](IMPORTANT): got command report touch sea_water_temperature
2018-09-24T20:25:28.614Z,1537820728.614 [Default] Stopped
2018-09-24T20:25:28.615Z,1537820728.615 [Default](DEBUG): Aggregate::uninitialize Default
2018-09-24T20:25:28.615Z,1537820728.615 [Default:B.GoToSurface] Stopped
2018-09-24T20:25:28.615Z,1537820728.615 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-24T20:25:28.615Z,1537820728.615 [Default:CheckIn] Stopped
2018-09-24T20:25:28.615Z,1537820728.615 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-24T20:25:28.615Z,1537820728.615 [Default:CheckIn:C.Wait] Stopped
2018-09-24T20:25:28.615Z,1537820728.615 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2018-09-24T20:25:28.615Z,1537820728.615 [MissionManager](IMPORTANT): Started mission Science
2018-09-24T20:25:28.616Z,1537820728.616 [Science] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science](DEBUG): Aggregate::initialize Science
2018-09-24T20:25:28.616Z,1537820728.616 [Science:A] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science:B] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science:C] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science:D] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science:E] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science:F] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science:G] Running Loop=1
2018-09-24T20:25:28.616Z,1537820728.616 [Science:Read_Oil] Running Loop=1
2018-09-24T20:25:28.617Z,1537820728.617 [Science:PeakDetectChl] Running Loop=1
2018-09-24T20:25:28.617Z,1537820728.617 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2018-09-24T20:25:28.617Z,1537820728.617 [Science:PeakDetectChl:A] Running Loop=1
2018-09-24T20:25:28.617Z,1537820728.617 [Science:HighestChlPeakReport] Running Loop=1
2018-09-24T20:25:28.617Z,1537820728.617 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2018-09-24T20:25:28.617Z,1537820728.617 [Science:HighestChlPeakReport:A] Running Loop=1
2018-09-24T20:25:28.617Z,1537820728.617 [Science:PeakDetectNO3] Running Loop=1
2018-09-24T20:25:28.618Z,1537820728.618 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2018-09-24T20:25:28.618Z,1537820728.618 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2018-09-24T20:25:28.618Z,1537820728.618 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-09-24T20:25:28.624Z,1537820728.624 [Science:PeakDetectOil] Running Loop=1
2018-09-24T20:25:28.624Z,1537820728.624 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2018-09-24T20:25:28.624Z,1537820728.624 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2018-09-24T20:25:28.624Z,1537820728.624 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2018-09-24T20:25:28.654Z,1537820728.654 [Science:PeakDetectOil] Stopped
2018-09-24T20:25:28.654Z,1537820728.654 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2018-09-24T20:25:28.655Z,1537820728.655 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2018-09-24T20:25:28.655Z,1537820728.655 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-09-24T20:25:28.655Z,1537820728.655 [Science:PeakDetectNO3] Stopped
2018-09-24T20:25:28.655Z,1537820728.655 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2018-09-24T20:25:28.655Z,1537820728.655 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2018-09-24T20:25:28.655Z,1537820728.655 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-09-24T20:25:28.655Z,1537820728.655 [Science:HighestChlPeakReport] Stopped
2018-09-24T20:25:28.655Z,1537820728.655 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2018-09-24T20:25:28.655Z,1537820728.655 [Science:HighestChlPeakReport:A] Stopped
2018-09-24T20:25:28.655Z,1537820728.655 [Science:PeakDetectChl] Stopped
2018-09-24T20:25:28.656Z,1537820728.656 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2018-09-24T20:25:28.656Z,1537820728.656 [Science:PeakDetectChl:A] Stopped
2018-09-24T20:25:28.656Z,1537820728.656 [Science:Read_Oil] Running Loop=1
2018-09-24T20:25:28.656Z,1537820728.656 [Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2018-09-24T20:25:28.658Z,1537820728.658 [Science:G] Stopped
2018-09-24T20:25:28.658Z,1537820728.658 [Science:F] Stopped
2018-09-24T20:25:28.658Z,1537820728.658 [Science:E] Stopped
2018-09-24T20:25:28.658Z,1537820728.658 [Science:D] Stopped
2018-09-24T20:25:28.658Z,1537820728.658 [Science:C] Running Loop=1
2018-09-24T20:25:28.659Z,1537820728.659 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2018-09-24T20:25:28.660Z,1537820728.660 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2018-09-24T20:25:28.663Z,1537820728.663 [Science:B] Stopped
2018-09-24T20:25:28.663Z,1537820728.663 [Science:A] Stopped
2018-09-24T20:25:28.841Z,1537820728.841 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2018-09-24T20:25:29.057Z,1537820729.057 [WetLabsSeaOWL_UV_A](INFO): Opening uart, block timeout 10ths=4
2018-09-24T20:25:29.057Z,1537820729.057 [WetLabsSeaOWL_UV_A](INFO): Powering up
2018-09-24T20:25:35.985Z,1537820735.985 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2018-09-24T20:25:35.986Z,1537820735.986 [CTD_NeilBrown] Communications Fault, FailCount= 1
2018-09-24T20:25:35.986Z,1537820735.986 [CTD_NeilBrown](ERROR): Communications Fault
2018-09-24T20:25:36.208Z,1537820736.208 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2018-09-24T20:25:36.209Z,1537820736.209 [CBIT](FAULT): Communications Fault in component: CTD_NeilBrown
2018-09-24T20:25:49.907Z,1537820749.907 [CommandLine](IMPORTANT): got command configSet list
2018-09-24T20:25:49.907Z,1537820749.907 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-09-24T20:25:49.908Z,1537820749.908 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;

2018-09-24T20:25:49.908Z,1537820749.908 [CommandLine](IMPORTANT): BPC1.batterySamplingInterval=1 hour;

2018-09-24T20:25:49.909Z,1537820749.909 [CommandLine](IMPORTANT): BuoyancyServo.accel=400 none;

2018-09-24T20:25:49.909Z,1537820749.909 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpCoefficient=1 none;

2018-09-24T20:25:49.909Z,1537820749.909 [CommandLine](IMPORTANT): BuoyancyServo.velocity=300 none;

2018-09-24T20:25:49.909Z,1537820749.909 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=1 bool;

2018-09-24T20:25:49.909Z,1537820749.909 [CommandLine](IMPORTANT): CTD_NeilBrown.simulateHardware=1 bool;

2018-09-24T20:25:49.909Z,1537820749.909 [CommandLine](IMPORTANT): Express linearApproximation RDI_Pathfinder.height_above_sea_floor 5.000000 meter;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_chlorophyll_in_sea_water 0.500000 microgram_per_liter;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): IBIT.batteryVoltageThreshold=13.7 volt;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): RDI_PathfinderUp.loadAtStartup=0 bool;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=205 cubic_centimeter;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): VerticalControl.massDefault=0 millimeter;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;

2018-09-24T20:25:49.910Z,1537820749.910 [CommandLine](IMPORTANT): WetLabsBB2FL.simulateHardware=0 bool;

2018-09-24T20:26:03.130Z,1537820763.130 [CommandLine](IMPORTANT): got command show variable CTD_NeilBrown
2018-09-24T20:26:03.191Z,1537820763.191 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup (bool)
2018-09-24T20:26:03.192Z,1537820763.192 [CommandLine](IMPORTANT): CTD_NeilBrown.simulateHardware (bool)
2018-09-24T20:26:03.192Z,1537820763.192 [CommandLine](IMPORTANT): CTD_NeilBrown.power (watt)
2018-09-24T20:26:03.221Z,1537820763.221 [CommandLine](IMPORTANT): CTD_NeilBrown.maxPressBound (decibar)
2018-09-24T20:26:03.222Z,1537820763.222 [CommandLine](IMPORTANT): CTD_NeilBrown.minPressBound (decibar)
2018-09-24T20:26:03.222Z,1537820763.222 [CommandLine](IMPORTANT): CTD_NeilBrown.offset (decibar)
2018-09-24T20:26:03.223Z,1537820763.223 [CommandLine](IMPORTANT): CTD_NeilBrown.maxSalinityBound (practical_salinity_unit)
2018-09-24T20:26:03.223Z,1537820763.223 [CommandLine](IMPORTANT): CTD_NeilBrown.minSalinityBound (practical_salinity_unit)
2018-09-24T20:26:03.320Z,1537820763.320 [CommandLine](IMPORTANT): CTD_NeilBrown.loadControl (none)
2018-09-24T20:26:03.320Z,1537820763.320 [CommandLine](IMPORTANT): CTD_NeilBrown.uart (none)
2018-09-24T20:26:03.326Z,1537820763.326 [CommandLine](IMPORTANT): CTD_NeilBrown.baud (bit_per_second)
2018-09-24T20:26:03.477Z,1537820763.477 [CommandLine](IMPORTANT): CTD_NeilBrown.sea_water_density (kilogram_per_cubic_meter)
2018-09-24T20:26:03.477Z,1537820763.477 [CommandLine](IMPORTANT): CTD_NeilBrown.depth (meter)
2018-09-24T20:26:03.478Z,1537820763.478 [CommandLine](IMPORTANT): CTD_NeilBrown.sea_water_pressure (decibar)
2018-09-24T20:26:03.478Z,1537820763.478 [CommandLine](IMPORTANT): CTD_NeilBrown.sea_water_salinity (practical_salinity_unit)
2018-09-24T20:26:03.479Z,1537820763.479 [CommandLine](IMPORTANT): CTD_NeilBrown.sea_water_temperature (celsius)
2018-09-24T20:26:03.479Z,1537820763.479 [CommandLine](IMPORTANT): CTD_NeilBrown.sea_water_electrical_conductivity (unspecified)
2018-09-24T20:26:03.479Z,1537820763.479 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_median_sea_water_electrical_conductivity (millimho_per_centimeter)
2018-09-24T20:26:03.480Z,1537820763.480 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_mean_sea_water_electrical_conductivity (millimho_per_centimeter)
2018-09-24T20:26:03.480Z,1537820763.480 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_standard_deviation_sea_water_electrical_conductivity (millimho_per_centimeter)
2018-09-24T20:26:03.485Z,1537820763.485 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_median_sea_water_temperature (celsius)
2018-09-24T20:26:03.485Z,1537820763.485 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_mean_sea_water_temperature (celsius)
2018-09-24T20:26:03.486Z,1537820763.486 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_standard_deviation_sea_water_temperature (celsius)
2018-09-24T20:26:03.486Z,1537820763.486 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_median_sea_water_salinity (practical_salinity_unit)
2018-09-24T20:26:03.487Z,1537820763.487 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_mean_sea_water_salinity (practical_salinity_unit)
2018-09-24T20:26:03.487Z,1537820763.487 [CommandLine](IMPORTANT): CTD_NeilBrown.bin_standard_deviation_sea_water_salinity (practical_salinity_unit)
2018-09-24T20:26:03.602Z,1537820763.602 [CommandLine](IMPORTANT): CTD_NeilBrown.durationOfLastRun (second)
2018-09-24T20:26:17.933Z,1537820777.933 [CommandLine](IMPORTANT): got command get CTD_NeilBrown.simulateHardware
2018-09-24T20:26:17.934Z,1537820777.934 [CommandLine](IMPORTANT): CTD_NeilBrown.simulateHardware 1 bool
2018-09-24T20:26:21.954Z,1537820781.954 [CommandLine](IMPORTANT): got command failComponent
2018-09-24T20:26:21.954Z,1537820781.954 [CommandLine](IMPORTANT): Failed components:
2018-09-24T20:26:21.954Z,1537820781.954 [CommandLine](IMPORTANT): CTD_NeilBrown: Communications Fault
2018-09-24T20:26:53.040Z,1537820813.040 [CommandLine](IMPORTANT): got command maintain sensor sea_water_temperature 12.000000 celsius
2018-09-24T20:26:53.042Z,1537820813.042 [ComponentRegistry](DEBUG): SyncComponent "Maintain_sea_water_temperature" handled in the control thread.
2018-09-24T20:26:53.391Z,1537820813.391 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,BPC1,Depth_Keller,Maintain_sea_water_temperature,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-09-24T20:26:59.600Z,1537820819.600 [CommandLine](IMPORTANT): got command get sea_water_temperature
2018-09-24T20:26:59.600Z,1537820819.600 [CommandLine](FAULT): Element has no value
2018-09-24T20:27:16.055Z,1537820836.055 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2018-09-24T20:27:25.183Z,1537820845.183 [CommandLine](IMPORTANT): got command maintain sensor CTD_NeilBrown.sea_water_temperature 12.000000 celsius
2018-09-24T20:27:25.185Z,1537820845.185 [ComponentRegistry](DEBUG): SyncComponent "Maintain_CTD_NeilBrown.sea_water_temperature" handled in the control thread.
2018-09-24T20:27:25.300Z,1537820845.300 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,RDI_Pathfinder,SCPI,BPC1,Depth_Keller,Maintain_sea_water_temperature,Maintain_CTD_NeilBrown.sea_water_temperature,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-09-24T20:27:25.730Z,1537820845.730 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:26.076Z,1537820846.076 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:26.474Z,1537820846.474 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:26.877Z,1537820846.877 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:27.286Z,1537820847.286 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:27.719Z,1537820847.719 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:28.113Z,1537820848.113 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:28.498Z,1537820848.498 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:28.766Z,1537820848.766 [CommandLine](IMPORTANT): got command failComponent
2018-09-24T20:27:28.766Z,1537820848.766 [CommandLine](IMPORTANT): Failed components:
2018-09-24T20:27:28.766Z,1537820848.766 [CommandLine](IMPORTANT): CTD_NeilBrown: Communications Fault
2018-09-24T20:27:28.936Z,1537820848.936 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:29.286Z,1537820849.286 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:29.670Z,1537820849.670 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:30.102Z,1537820850.102 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:30.473Z,1537820850.473 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:30.886Z,1537820850.886 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:31.313Z,1537820851.313 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:31.684Z,1537820851.684 [Reporter](INFO): sea_water_temperature 11.999994 degC
2018-09-24T20:27:32.024Z,1537820852.024 [CommandLine](IMPORTANT): got command report clear
2018-09-24T20:27:38.060Z,1537820858.060 [CommandLine](IMPORTANT): got command show stack
2018-09-24T20:27:38.060Z,1537820858.060 [CommandLine](IMPORTANT): Behavior Stack:

2018-09-24T20:27:38.061Z,1537820858.061 [Science](IMPORTANT): Priority 0: Science:C
2018-09-24T20:27:38.061Z,1537820858.061 [Science](IMPORTANT): Priority 1: Science:Read_Oil
2018-09-24T20:27:44.776Z,1537820864.776 [CommandLine](IMPORTANT): got command show variable PeakChl
2018-09-24T20:27:45.040Z,1537820865.040 [CommandLine](IMPORTANT): Science.PeakChlShallowBound (meter)
2018-09-24T20:27:45.040Z,1537820865.040 [CommandLine](IMPORTANT): Science.PeakChlDeepBound (meter)
2018-09-24T20:27:45.041Z,1537820865.041 [CommandLine](IMPORTANT): Science.PeakChl (microgram_per_liter)
2018-09-24T20:27:45.042Z,1537820865.042 [CommandLine](IMPORTANT): Science.PeakChlDepth (meter)
2018-09-24T20:27:45.042Z,1537820865.042 [CommandLine](IMPORTANT): Science.PeakChlTemperature (celsius)
2018-09-24T20:27:45.043Z,1537820865.043 [CommandLine](IMPORTANT): Science.PeakChlLatitude (degree)
2018-09-24T20:27:45.043Z,1537820865.043 [CommandLine](IMPORTANT): Science.PeakChlLongitude (degree)
2018-09-24T20:27:46.042Z,1537820866.042 [RDI_Pathfinder](ERROR): DVL BIT error. See manual. Result code: 32768
2018-09-24T20:27:46.043Z,1537820866.043 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-32768,-32768,V
2018-09-24T20:27:51.719Z,1537820871.719 [CommandLine](IMPORTANT): got command report touch Science.PeakChl
2018-09-24T20:27:56.135Z,1537820876.135 [CommandLine](IMPORTANT): got command show variable peakDet
2018-09-24T20:27:56.355Z,1537820876.355 [CommandLine](IMPORTANT): Science.PeakDetectChlActive (bool)
2018-09-24T20:27:56.356Z,1537820876.356 [CommandLine](IMPORTANT): Science.PeakDetectNO3Active (bool)
2018-09-24T20:27:56.356Z,1537820876.356 [CommandLine](IMPORTANT): Science.PeakDetectOilActive (bool)
2018-09-24T20:28:07.094Z,1537820887.094 [CommandLine](IMPORTANT): got command set Science.PeakDetectChlActive 1.000000 bool
2018-09-24T20:28:08.509Z,1537820888.509 [Science:PeakDetectChl] Running Loop=1
2018-09-24T20:28:08.510Z,1537820888.510 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2018-09-24T20:28:08.510Z,1537820888.510 [Science:PeakDetectChl:A] Running Loop=1
2018-09-24T20:28:08.510Z,1537820888.510 [Science:PeakDetectChl] Running Loop=1
2018-09-24T20:28:08.510Z,1537820888.510 [Science:PeakDetectChl:A](IMPORTANT): Calling peak detect vs depth
2018-09-24T20:28:08.512Z,1537820888.512 [Science:PeakDetectChl:A] Stopped
2018-09-24T20:28:08.512Z,1537820888.512 [Science:PeakDetectChl:B.PeakDetectVsDepth] Running Loop=1
2018-09-24T20:28:08.512Z,1537820888.512 [Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Initialize.
2018-09-24T20:28:08.514Z,1537820888.514 [Science:G] Running Loop=1
2018-09-24T20:28:08.514Z,1537820888.514 [Science:G] Running Loop=1
2018-09-24T20:28:08.514Z,1537820888.514 [Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2018-09-24T20:28:24.504Z,1537820904.504 [CommandLine](IMPORTANT): got command get sea_water_temperature
2018-09-24T20:28:24.505Z,1537820904.505 [CommandLine](IMPORTANT): sea_water_temperature 11.999994 degC
2018-09-24T20:28:39.965Z,1537820919.965 [CommandLine](IMPORTANT): got command failComponent none CTD_NeilBrown
2018-09-24T20:28:39.965Z,1537820919.965 [CTD_NeilBrown] No Fault, FailCount= 1
2018-09-24T20:28:39.966Z,1537820919.966 [CommandLine](IMPORTANT): CTD_NeilBrown failureMode is No Fault
2018-09-24T20:28:40.117Z,1537820920.117 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2018-09-24T20:28:47.261Z,1537820927.261 [CTD_NeilBrown](FAULT): No CTD communication! Re-initializing
2018-09-24T20:28:47.262Z,1537820927.262 [CTD_NeilBrown] Communications Fault, FailCount= 2
2018-09-24T20:28:47.262Z,1537820927.262 [CTD_NeilBrown](ERROR): Communications Fault
2018-09-24T20:28:47.415Z,1537820927.415 [CBIT](ERROR): Communications Fault in component: CTD_NeilBrown
2018-09-24T20:28:47.416Z,1537820927.416 [CBIT](FAULT): Communications Fault in component: CTD_NeilBrown
2018-09-24T20:28:48.883Z,1537820928.883 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2018-09-24T20:28:51.679Z,1537820931.679 [CommandLine](IMPORTANT): got command show variable shallowB
2018-09-24T20:28:51.705Z,1537820931.705 [CommandLine](IMPORTANT): TempGradientCalculator.depShallowBndForAvg (meter)
2018-09-24T20:28:51.956Z,1537820931.956 [CommandLine](IMPORTANT): Science.PeakChlShallowBound (meter)
2018-09-24T20:28:57.648Z,1537820937.648 [CommandLine](IMPORTANT): got command get Science.PeakChlShallowBound
2018-09-24T20:28:57.648Z,1537820937.648 [CommandLine](IMPORTANT): Science.PeakChlShallowBound 10.000000 m
2018-09-24T20:29:06.626Z,1537820946.626 [CommandLine](IMPORTANT): got command set Science.PeakChlShallowBound 0.000000 meter
2018-09-24T20:29:13.293Z,1537820953.293 [CommandLine](IMPORTANT): got command stop
2018-09-24T20:29:13.293Z,1537820953.293 [CommandLine](IMPORTANT): Scheduling is paused
2018-09-24T20:29:13.293Z,1537820953.293 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2018-09-24T20:29:13.640Z,1537820953.640 [MissionManager](INFO): MissionManager is completed.
2018-09-24T20:29:13.640Z,1537820953.640 [MissionManager](INFO): Uninitializing Mission Science
2018-09-24T20:29:13.640Z,1537820953.640 [Science] Stopped
2018-09-24T20:29:13.641Z,1537820953.641 [Science](DEBUG): Aggregate::uninitialize Science
2018-09-24T20:29:13.642Z,1537820953.642 [Science:C] Stopped
2018-09-24T20:29:13.642Z,1537820953.642 [Science:G] Stopped
2018-09-24T20:29:13.642Z,1537820953.642 [Science:Read_Oil] Stopped
2018-09-24T20:29:13.642Z,1537820953.642 [Science:PeakDetectChl] Stopped
2018-09-24T20:29:13.642Z,1537820953.642 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2018-09-24T20:29:13.643Z,1537820953.643 [Science:PeakDetectChl:B.PeakDetectVsDepth] Stopped
2018-09-24T20:29:13.643Z,1537820953.643 [Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Uninitialize.
2018-09-24T20:29:13.945Z,1537820953.945 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-24T20:29:14.052Z,1537820954.052 [MissionManager](IMPORTANT): Started mission Default
2018-09-24T20:29:14.052Z,1537820954.052 [Default] Running Loop=1
2018-09-24T20:29:14.052Z,1537820954.052 [Default](DEBUG): Aggregate::initialize Default
2018-09-24T20:29:14.052Z,1537820954.052 [Default:B.GoToSurface] Running Loop=1
2018-09-24T20:29:14.052Z,1537820954.052 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-09-24T20:29:14.057Z,1537820954.057 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-09-24T20:29:14.057Z,1537820954.057 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-09-24T20:29:14.058Z,1537820954.058 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-09-24T20:29:14.058Z,1537820954.058 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-09-24T20:29:14.058Z,1537820954.058 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-09-24T20:29:14.059Z,1537820954.059 [Default:A.Wait] Running Loop=1
2018-09-24T20:29:14.059Z,1537820954.059 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-09-24T20:29:22.414Z,1537820962.414 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2018-09-24T20:29:22.414Z,1537820962.414 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,180924133459090.1,   0.0,1448.9,  0
2018-09-24T20:29:27.214Z,1537820967.214 [Default:A.Wait](INFO): Done Waiting.
2018-09-24T20:29:27.215Z,1537820967.215 [Default:A.Wait] Stopped
2018-09-24T20:29:27.215Z,1537820967.215 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-09-24T20:29:27.618Z,1537820967.618 [Default:CheckIn] Running Loop=1
2018-09-24T20:29:27.618Z,1537820967.618 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-09-24T20:29:27.618Z,1537820967.618 [Default:CheckIn:Read_GPS] Running Loop=1
2018-09-24T20:29:28.378Z,1537820968.378 [NAL9602](INFO): Powering up
2018-09-24T20:29:39.570Z,1537820979.570 [NAL9602](INFO): NAL9602 initialized
2018-09-24T20:29:56.786Z,1537820996.786 [NAL9602](INFO): SBD MO Status=0, MOMSN=1613, MT Status=0, MTMSN=0
2018-09-24T20:29:56.786Z,1537820996.786 [NAL9602](INFO): No messages in MT queue
2018-09-24T20:30:09.022Z,1537821009.022 [CommandLine](IMPORTANT): got command get depth
2018-09-24T20:30:09.022Z,1537821009.022 [CommandLine](IMPORTANT): depth 0.329802 m
2018-09-24T20:30:13.180Z,1537821013.180 [CommandLine](IMPORTANT): got command get depth
2018-09-24T20:30:13.181Z,1537821013.181 [CommandLine](IMPORTANT): depth 0.311261 m
2018-09-24T20:30:17.764Z,1537821017.764 [CommandLine](IMPORTANT): got command get depth
2018-09-24T20:30:17.765Z,1537821017.765 [CommandLine](IMPORTANT): depth 0.307190 m
2018-09-24T20:30:25.112Z,1537821025.112 [CommandLine](IMPORTANT): got command get depth
2018-09-24T20:30:25.115Z,1537821025.115 [CommandLine](IMPORTANT): depth 0.329802 m
2018-09-24T20:30:35.370Z,1537821035.370 [CommandLine](IMPORTANT): got command failComponent
2018-09-24T20:30:35.370Z,1537821035.370 [CommandLine](IMPORTANT): Failed components:
2018-09-24T20:30:35.371Z,1537821035.371 [CommandLine](IMPORTANT): CTD_NeilBrown: Communications Fault
2018-09-24T20:31:10.040Z,1537821070.040 [RDI_Pathfinder](ERROR): Failed to parse:

2018-09-24T20:32:33.546Z,1537821153.546 [NAL9602](INFO): GPS fix at 20180924T203225: (36.851142, -121.915566)
2018-09-24T20:32:33.602Z,1537821153.602 [Default:CheckIn:Read_GPS] Stopped
2018-09-24T20:32:33.603Z,1537821153.603 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-09-24T20:32:38.575Z,1537821158.575 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20180924T201931/Courier0007.lzma
2018-09-24T20:32:39.362Z,1537821159.362 [DataOverHttps](INFO): Moved sent file to Logs/20180924T201931/Courier0007.lzma.bak
2018-09-24T20:32:39.362Z,1537821159.362 [DataOverHttps](IMPORTANT): SBD MOMSN=8575377, MTMSN=20180924T203231
2018-09-24T20:32:44.808Z,1537821164.808 [DataOverHttps](INFO): Received command:configSet CTD_Seabird.loadAtStartup 1 bool persist;configSet CTD_Seabird.simulateHardware 1 bool persist
2018-09-24T20:32:45.350Z,1537821165.350 [CommandLine](IMPORTANT): got command configSet CTD_Seabird.loadAtStartup 1.000000 bool persist
2018-09-24T20:32:45.351Z,1537821165.351 [CommandLine](IMPORTANT): configSet CTD_Seabird.loadAtStartup requires a restart to take effect.
2018-09-24T20:32:45.354Z,1537821165.354 [CommandLine](IMPORTANT): got command configSet CTD_Seabird.simulateHardware 1.000000 bool persist
2018-09-24T20:32:50.066Z,1537821170.066 [DataOverHttps](INFO): Sending 2207 bytes from file Logs/20180924T201931/Express0008.lzma
2018-09-24T20:32:51.217Z,1537821171.217 [DataOverHttps](INFO): Moved sent file to Logs/20180924T201931/Express0008.lzma.bak
2018-09-24T20:32:51.218Z,1537821171.218 [DataOverHttps](INFO): SBD MOMSN=8575381
2018-09-24T20:32:59.772Z,1537821179.772 [CommandLine](IMPORTANT): got command restart application
2018-09-24T20:33:00.780Z,1537821180.780 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-24T20:33:00.780Z,1537821180.780 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:00.865Z,1537821180.865 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-09-24T20:33:00.865Z,1537821180.865 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:00.866Z,1537821180.866 [CommandLine](INFO): Join timeout helper Thread ID is 3073
2018-09-24T20:33:00.869Z,1537821180.869 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-09-24T20:33:00.869Z,1537821180.869 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:00.870Z,1537821180.870 [NavChartDb](INFO): Join timeout helper Thread ID is 3074
2018-09-24T20:33:00.881Z,1537821180.881 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-24T20:33:00.881Z,1537821180.881 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:00.897Z,1537821180.897 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-09-24T20:33:00.897Z,1537821180.897 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:00.900Z,1537821180.900 [Radio_Surface](INFO): Join timeout helper Thread ID is 3075
2018-09-24T20:33:01.109Z,1537821181.109 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-24T20:33:01.109Z,1537821181.109 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.117Z,1537821181.117 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2018-09-24T20:33:01.117Z,1537821181.117 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.117Z,1537821181.117 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 3076
2018-09-24T20:33:01.125Z,1537821181.125 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-24T20:33:01.125Z,1537821181.125 [WetLabsSeaOWL_UV_A](INFO): Powering down
2018-09-24T20:33:01.126Z,1537821181.126 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.129Z,1537821181.129 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2018-09-24T20:33:01.129Z,1537821181.129 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.129Z,1537821181.129 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 3077
2018-09-24T20:33:01.352Z,1537821181.352 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20180924T201931/Courier0010.lzma
2018-09-24T20:33:01.529Z,1537821181.529 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-24T20:33:01.529Z,1537821181.529 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.534Z,1537821181.534 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-09-24T20:33:01.534Z,1537821181.534 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.534Z,1537821181.534 [logger](INFO): Join timeout helper Thread ID is 3078
2018-09-24T20:33:01.561Z,1537821181.561 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-24T20:33:01.561Z,1537821181.561 [logger ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.574Z,1537821181.574 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-09-24T20:33:01.574Z,1537821181.574 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.574Z,1537821181.574 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-09-24T20:33:01.574Z,1537821181.574 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.574Z,1537821181.574 [controlThread](INFO): Join timeout helper Thread ID is 3079
2018-09-24T20:33:01.701Z,1537821181.701 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-09-24T20:33:01.701Z,1537821181.701 [controlThread](DEBUG): Uninitializing ControlThread
2018-09-24T20:33:01.702Z,1537821181.702 [AHRS_M2](INFO): Powering down
2018-09-24T20:33:01.777Z,1537821181.777 [NAL9602](INFO): Powering down
2018-09-24T20:33:01.849Z,1537821181.849 [RDI_Pathfinder](INFO): Powering down
2018-09-24T20:33:01.851Z,1537821181.851 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-09-24T20:33:01.852Z,1537821181.852 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-09-24T20:33:01.852Z,1537821181.852 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-09-24T20:33:01.853Z,1537821181.853 [MissionManager](INFO): Uninitializing Mission Default
2018-09-24T20:33:01.853Z,1537821181.853 [Default] Stopped
2018-09-24T20:33:01.853Z,1537821181.853 [Default](DEBUG): Aggregate::uninitialize Default
2018-09-24T20:33:01.853Z,1537821181.853 [Default:B.GoToSurface] Stopped
2018-09-24T20:33:01.854Z,1537821181.854 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-09-24T20:33:01.854Z,1537821181.854 [Default:CheckIn] Stopped
2018-09-24T20:33:01.854Z,1537821181.854 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-09-24T20:33:01.854Z,1537821181.854 [Default:CheckIn:Read_Iridium] Stopped
2018-09-24T20:33:01.857Z,1537821181.857 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-09-24T20:33:01.857Z,1537821181.857 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-09-24T20:33:01.858Z,1537821181.858 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-09-24T20:33:01.858Z,1537821181.858 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-09-24T20:33:01.858Z,1537821181.858 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-09-24T20:33:01.858Z,1537821181.858 [BuoyancyServo](INFO): Powering down
2018-09-24T20:33:01.873Z,1537821181.873 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-09-24T20:33:01.873Z,1537821181.873 [ElevatorServo](INFO): Powering down
2018-09-24T20:33:01.874Z,1537821181.874 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-09-24T20:33:01.874Z,1537821181.874 [MassServo](INFO): Powering down
2018-09-24T20:33:01.875Z,1537821181.875 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-09-24T20:33:01.875Z,1537821181.875 [RudderServo](INFO): Powering down
2018-09-24T20:33:01.876Z,1537821181.876 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-09-24T20:33:01.876Z,1537821181.876 [ThrusterServo](INFO): Powering down
2018-09-24T20:33:01.877Z,1537821181.877 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-09-24T20:33:01.878Z,1537821181.878 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-09-24T20:33:01.878Z,1537821181.878 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-09-24T20:33:01.879Z,1537821181.879 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.940Z,1537821181.940 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:01.943Z,1537821181.943 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:02.003Z,1537821182.003 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:02.047Z,1537821182.047 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-09-24T20:33:02.106Z,1537821182.106 [logger ThreadHandler](INFO): Thread cancelled.