2020-08-31T16:43:34.027Z,1598892214.027 [Supervisor](DEBUG): Initializing supervisor.
2020-08-31T16:43:34.029Z,1598892214.029 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-08-31T16:43:34.030Z,1598892214.030 [SyncHandler](INFO): Protected caller Thread ID is 5276
2020-08-31T16:43:34.030Z,1598892214.030 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-08-31T16:43:34.031Z,1598892214.031 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-08-31T16:43:34.031Z,1598892214.031 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5277
2020-08-31T16:43:34.034Z,1598892214.034 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-08-31T16:43:34.047Z,1598892214.047 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-08-31T16:43:34.048Z,1598892214.048 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-08-31T16:43:34.048Z,1598892214.048 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5278
2020-08-31T16:43:34.049Z,1598892214.049 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-08-31T16:43:34.050Z,1598892214.050 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-08-31T16:43:34.050Z,1598892214.050 [logger ThreadHandler](INFO): Protected caller Thread ID is 5279
2020-08-31T16:43:34.052Z,1598892214.052 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-08-31T16:43:34.052Z,1598892214.052 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-08-31T16:43:34.054Z,1598892214.054 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-08-31T16:43:34.146Z,1598892214.146 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-08-31T16:43:34.147Z,1598892214.147 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-08-31T16:43:34.727Z,1598892214.727 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-08-31T16:43:34.727Z,1598892214.727 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2020-08-31T16:43:34.915Z,1598892214.915 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2020-08-31T16:43:34.915Z,1598892214.915 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-08-31T16:43:35.012Z,1598892215.012 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-08-31T16:43:35.012Z,1598892215.012 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-08-31T16:43:35.111Z,1598892215.111 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-08-31T16:43:35.111Z,1598892215.111 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-08-31T16:43:35.190Z,1598892215.190 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-08-31T16:43:35.324Z,1598892215.324 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-08-31T16:43:35.324Z,1598892215.324 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-08-31T16:43:35.604Z,1598892215.604 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-08-31T16:43:35.605Z,1598892215.605 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-08-31T16:43:36.044Z,1598892216.044 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-08-31T16:43:36.045Z,1598892216.045 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-08-31T16:43:36.184Z,1598892216.184 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-08-31T16:43:36.185Z,1598892216.185 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-08-31T16:43:36.372Z,1598892216.372 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-08-31T16:43:36.372Z,1598892216.372 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-08-31T16:43:36.828Z,1598892216.828 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-08-31T16:43:36.829Z,1598892216.829 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-08-31T16:43:37.038Z,1598892217.038 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-08-31T16:43:37.039Z,1598892217.039 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-08-31T16:43:37.236Z,1598892217.236 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-08-31T16:43:37.236Z,1598892217.236 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-08-31T16:43:37.633Z,1598892217.633 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-08-31T16:43:37.634Z,1598892217.634 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-08-31T16:43:37.955Z,1598892217.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-08-31T16:43:37.957Z,1598892217.957 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2020-08-31T16:43:37.958Z,1598892217.958 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2020-08-31T16:43:38.038Z,1598892218.038 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2020-08-31T16:43:38.192Z,1598892218.192 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2020-08-31T16:43:38.297Z,1598892218.297 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2020-08-31T16:43:38.380Z,1598892218.380 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2020-08-31T16:43:38.471Z,1598892218.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2020-08-31T16:43:38.667Z,1598892218.667 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2020-08-31T16:43:39.252Z,1598892219.252 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-08-31T16:43:39.252Z,1598892219.252 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2020-08-31T16:43:39.410Z,1598892219.410 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2020-08-31T16:43:39.608Z,1598892219.608 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2020-08-31T16:43:39.783Z,1598892219.783 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2020-08-31T16:43:39.880Z,1598892219.880 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-08-31T16:43:39.890Z,1598892219.890 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2020-08-31T16:43:39.965Z,1598892219.965 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2020-08-31T16:43:39.965Z,1598892219.965 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-08-31T16:43:40.012Z,1598892220.012 [VerticalControl](DEBUG): Construct VerticalControl.
2020-08-31T16:43:40.119Z,1598892220.119 [VerticalControl] Loaded
2020-08-31T16:43:40.119Z,1598892220.119 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-08-31T16:43:40.120Z,1598892220.120 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-08-31T16:43:40.196Z,1598892220.196 [HorizontalControl] Loaded
2020-08-31T16:43:40.197Z,1598892220.197 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-08-31T16:43:40.197Z,1598892220.197 [SpeedControl](DEBUG): Construct SpeedControl.
2020-08-31T16:43:40.203Z,1598892220.203 [SpeedControl] Loaded
2020-08-31T16:43:40.203Z,1598892220.203 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-08-31T16:43:40.203Z,1598892220.203 [LoopControl](DEBUG): Construct LoopControl.
2020-08-31T16:43:40.204Z,1598892220.204 [LoopControl] Loaded
2020-08-31T16:43:40.204Z,1598892220.204 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-08-31T16:43:40.205Z,1598892220.205 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-08-31T16:43:40.205Z,1598892220.205 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-08-31T16:43:40.245Z,1598892220.245 [DepthRateCalculator] Loaded
2020-08-31T16:43:40.245Z,1598892220.245 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-08-31T16:43:40.251Z,1598892220.251 [PitchRateCalculator] Loaded
2020-08-31T16:43:40.251Z,1598892220.251 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-08-31T16:43:40.265Z,1598892220.265 [SpeedCalculator] Loaded
2020-08-31T16:43:40.266Z,1598892220.266 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-08-31T16:43:40.286Z,1598892220.286 [TempGradientCalculator] Loaded
2020-08-31T16:43:40.286Z,1598892220.286 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-08-31T16:43:40.291Z,1598892220.291 [YawRateCalculator] Loaded
2020-08-31T16:43:40.291Z,1598892220.291 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-08-31T16:43:40.319Z,1598892220.319 [ElevatorOffsetCalculator] Loaded
2020-08-31T16:43:40.319Z,1598892220.319 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-08-31T16:43:40.320Z,1598892220.320 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-08-31T16:43:40.320Z,1598892220.320 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-08-31T16:43:40.346Z,1598892220.346 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-08-31T16:43:40.347Z,1598892220.347 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-08-31T16:43:40.428Z,1598892220.428 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-08-31T16:43:40.428Z,1598892220.428 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-08-31T16:43:40.709Z,1598892220.709 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-08-31T16:43:40.709Z,1598892220.709 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-08-31T16:43:40.806Z,1598892220.806 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-08-31T16:43:40.807Z,1598892220.807 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-08-31T16:43:41.105Z,1598892221.105 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-08-31T16:43:41.110Z,1598892221.110 [AHRS_M2](INFO): created writer for : platform_orientation
2020-08-31T16:43:41.112Z,1598892221.112 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-08-31T16:43:41.117Z,1598892221.117 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-08-31T16:43:41.117Z,1598892221.117 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-08-31T16:43:41.122Z,1598892221.122 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-08-31T16:43:41.123Z,1598892221.123 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-08-31T16:43:41.128Z,1598892221.128 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-08-31T16:43:41.197Z,1598892221.197 [AHRS_M2] Loaded
2020-08-31T16:43:41.197Z,1598892221.197 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-08-31T16:43:41.271Z,1598892221.271 [DataOverHttps] Loaded
2020-08-31T16:43:41.272Z,1598892221.272 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-08-31T16:43:41.273Z,1598892221.273 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090D4E0
2020-08-31T16:43:41.273Z,1598892221.273 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5361
2020-08-31T16:43:41.302Z,1598892221.302 [Depth_Keller] Loaded
2020-08-31T16:43:41.303Z,1598892221.303 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-08-31T16:43:41.307Z,1598892221.307 [DropWeight] Loaded
2020-08-31T16:43:41.307Z,1598892221.307 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-08-31T16:43:41.419Z,1598892221.419 [NAL9602] Loaded
2020-08-31T16:43:41.419Z,1598892221.419 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-08-31T16:43:41.466Z,1598892221.466 [Onboard] Loaded
2020-08-31T16:43:41.467Z,1598892221.467 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2020-08-31T16:43:41.468Z,1598892221.468 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093D4E0
2020-08-31T16:43:41.468Z,1598892221.468 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5362
2020-08-31T16:43:41.487Z,1598892221.487 [Radio_Surface] Loaded
2020-08-31T16:43:41.487Z,1598892221.487 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-08-31T16:43:41.488Z,1598892221.488 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096D4E0
2020-08-31T16:43:41.488Z,1598892221.488 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5363
2020-08-31T16:43:41.546Z,1598892221.546 [RDI_Pathfinder] Loaded
2020-08-31T16:43:41.546Z,1598892221.546 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-08-31T16:43:41.693Z,1598892221.693 [DAT] Loaded
2020-08-31T16:43:41.693Z,1598892221.693 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2020-08-31T16:43:43.160Z,1598892223.160 [BPC1] Loaded
2020-08-31T16:43:43.161Z,1598892223.161 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-08-31T16:43:43.192Z,1598892223.192 [AMEcho] Loaded
2020-08-31T16:43:43.193Z,1598892223.193 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread.
2020-08-31T16:43:43.193Z,1598892223.193 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-08-31T16:43:43.193Z,1598892223.193 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-08-31T16:43:43.377Z,1598892223.377 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-08-31T16:43:43.378Z,1598892223.378 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-08-31T16:43:43.397Z,1598892223.397 [NavChart] Loaded
2020-08-31T16:43:43.397Z,1598892223.397 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-08-31T16:43:43.402Z,1598892223.402 [UniversalFixResidualReporter] Loaded
2020-08-31T16:43:43.402Z,1598892223.402 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-08-31T16:43:43.402Z,1598892223.402 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-08-31T16:43:43.403Z,1598892223.403 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-08-31T16:43:43.536Z,1598892223.536 [SBIT](DEBUG): Construct Startup Built In Test.
2020-08-31T16:43:43.547Z,1598892223.547 [SBIT] Loaded
2020-08-31T16:43:43.547Z,1598892223.547 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-08-31T16:43:43.548Z,1598892223.548 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-08-31T16:43:43.560Z,1598892223.560 [IBIT] Loaded
2020-08-31T16:43:43.560Z,1598892223.560 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-08-31T16:43:43.563Z,1598892223.563 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-08-31T16:43:43.698Z,1598892223.698 [CBIT] Loaded
2020-08-31T16:43:43.698Z,1598892223.698 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-08-31T16:43:43.698Z,1598892223.698 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-08-31T16:43:43.699Z,1598892223.699 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-08-31T16:43:43.819Z,1598892223.819 [BuoyancyServo] Loaded
2020-08-31T16:43:43.819Z,1598892223.819 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-08-31T16:43:43.847Z,1598892223.847 [ElevatorServo] Loaded
2020-08-31T16:43:43.847Z,1598892223.847 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-08-31T16:43:43.874Z,1598892223.874 [MassServo] Loaded
2020-08-31T16:43:43.875Z,1598892223.875 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-08-31T16:43:43.901Z,1598892223.901 [RudderServo] Loaded
2020-08-31T16:43:43.901Z,1598892223.901 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-08-31T16:43:43.927Z,1598892223.927 [ThrusterServo] Loaded
2020-08-31T16:43:43.927Z,1598892223.927 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-08-31T16:43:43.928Z,1598892223.928 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-08-31T16:43:43.928Z,1598892223.928 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-08-31T16:43:43.947Z,1598892223.947 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-08-31T16:43:43.947Z,1598892223.947 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-08-31T16:43:44.178Z,1598892224.178 [BackSeatDriver] Loaded
2020-08-31T16:43:44.179Z,1598892224.179 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread.
2020-08-31T16:43:44.180Z,1598892224.180 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40B034E0
2020-08-31T16:43:44.180Z,1598892224.180 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 5365
2020-08-31T16:43:44.209Z,1598892224.209 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2020-08-31T16:43:44.214Z,1598892224.214 [CTD_Seabird](INFO): created writer for : sea_water_density
2020-08-31T16:43:44.214Z,1598892224.214 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2020-08-31T16:43:44.219Z,1598892224.219 [CTD_Seabird](INFO): created writer for : depth
2020-08-31T16:43:44.219Z,1598892224.219 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2020-08-31T16:43:44.224Z,1598892224.224 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2020-08-31T16:43:44.225Z,1598892224.225 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2020-08-31T16:43:44.230Z,1598892224.230 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2020-08-31T16:43:44.230Z,1598892224.230 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2020-08-31T16:43:44.235Z,1598892224.235 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2020-08-31T16:43:44.236Z,1598892224.236 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2020-08-31T16:43:44.241Z,1598892224.241 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2020-08-31T16:43:44.242Z,1598892224.242 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2020-08-31T16:43:44.247Z,1598892224.247 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2020-08-31T16:43:44.273Z,1598892224.273 [CTD_Seabird] Loaded
2020-08-31T16:43:44.273Z,1598892224.273 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2020-08-31T16:43:44.274Z,1598892224.274 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B334E0
2020-08-31T16:43:44.274Z,1598892224.274 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5366
2020-08-31T16:43:44.296Z,1598892224.296 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470
2020-08-31T16:43:44.296Z,1598892224.296 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470
2020-08-31T16:43:44.300Z,1598892224.300 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650
2020-08-31T16:43:44.301Z,1598892224.301 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650
2020-08-31T16:43:44.305Z,1598892224.305 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl
2020-08-31T16:43:44.305Z,1598892224.305 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl
2020-08-31T16:43:44.309Z,1598892224.309 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm
2020-08-31T16:43:44.310Z,1598892224.310 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm
2020-08-31T16:43:44.313Z,1598892224.313 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm
2020-08-31T16:43:44.314Z,1598892224.314 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm
2020-08-31T16:43:44.318Z,1598892224.318 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm
2020-08-31T16:43:44.318Z,1598892224.318 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm
2020-08-31T16:43:44.322Z,1598892224.322 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm
2020-08-31T16:43:44.322Z,1598892224.322 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm
2020-08-31T16:43:44.326Z,1598892224.326 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.331Z,1598892224.331 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.331Z,1598892224.331 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.331Z,1598892224.331 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.335Z,1598892224.335 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.336Z,1598892224.336 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.340Z,1598892224.340 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.340Z,1598892224.340 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:43:44.344Z,1598892224.344 [WetLabsBB2FL] Loaded
2020-08-31T16:43:44.344Z,1598892224.344 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2020-08-31T16:43:44.346Z,1598892224.346 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B634E0
2020-08-31T16:43:44.346Z,1598892224.346 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5367
2020-08-31T16:43:44.347Z,1598892224.347 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-08-31T16:43:44.356Z,1598892224.356 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-08-31T16:43:44.357Z,1598892224.357 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-08-31T16:43:44.389Z,1598892224.389 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-08-31T16:43:44.390Z,1598892224.390 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B934E0
2020-08-31T16:43:44.391Z,1598892224.391 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5368
2020-08-31T16:43:44.395Z,1598892224.395 [Supervisor](INFO): Main Thread ID is 5275
2020-08-31T16:43:44.396Z,1598892224.396 [Supervisor](DEBUG): Running supervisor.
2020-08-31T16:43:44.396Z,1598892224.396 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5369
2020-08-31T16:43:44.399Z,1598892224.399 [controlThread ThreadHandler](INFO): Handler Thread ID is 5370
2020-08-31T16:43:44.399Z,1598892224.399 [controlThread](DEBUG): Initializing ControlThread
2020-08-31T16:43:44.400Z,1598892224.400 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-08-31T16:43:44.402Z,1598892224.402 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-08-31T16:43:44.402Z,1598892224.402 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-08-31T16:43:44.403Z,1598892224.403 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-08-31T16:43:44.403Z,1598892224.403 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-08-31T16:43:44.403Z,1598892224.403 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-08-31T16:43:44.404Z,1598892224.404 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-08-31T16:43:44.404Z,1598892224.404 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-08-31T16:43:44.405Z,1598892224.405 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-08-31T16:43:44.405Z,1598892224.405 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-08-31T16:43:44.412Z,1598892224.412 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-08-31T16:43:44.413Z,1598892224.413 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-08-31T16:43:44.413Z,1598892224.413 [SBIT](INFO): Initialize SBIT Component.
2020-08-31T16:43:44.413Z,1598892224.413 [SBIT](IMPORTANT): git: 2020-08-31
2020-08-31T16:43:44.414Z,1598892224.414 [SBIT](INFO): git hash: b6c0ec5a69f4280de3f7606c4f2437bb78ebd873
2020-08-31T16:43:44.414Z,1598892224.414 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-08-31T16:43:44.415Z,1598892224.415 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2020-08-31T16:43:44.416Z,1598892224.416 [SBIT](INFO): Beginning SBIT in 65.000000 seconds.
2020-08-31T16:43:44.416Z,1598892224.416 [IBIT](INFO): Initialize IBIT Component.
2020-08-31T16:43:44.417Z,1598892224.417 [CBIT](DEBUG): Initialize CBIT Component.
2020-08-31T16:43:44.418Z,1598892224.418 [logger ThreadHandler](INFO): Handler Thread ID is 5371
2020-08-31T16:43:44.429Z,1598892224.429 [CBIT](DEBUG): Initialized mux pins.
2020-08-31T16:43:44.429Z,1598892224.429 [CBIT](DEBUG): Initializing the watchdog timer.
2020-08-31T16:43:44.442Z,1598892224.442 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5372
2020-08-31T16:43:44.444Z,1598892224.444 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-08-31T16:43:44.453Z,1598892224.453 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2020-08-31T16:43:44.453Z,1598892224.453 [CBIT](DEBUG): Initializing heartbeat.
2020-08-31T16:43:44.458Z,1598892224.458 [Onboard ThreadHandler](INFO): Handler Thread ID is 5373
2020-08-31T16:43:44.483Z,1598892224.483 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5374
2020-08-31T16:43:44.484Z,1598892224.484 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 5375
2020-08-31T16:43:44.488Z,1598892224.488 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5377
2020-08-31T16:43:44.494Z,1598892224.494 [WetLabsBB2FL](INFO): Powering down
2020-08-31T16:43:44.525Z,1598892224.525 [CBIT](DEBUG): Deactivating GF circuits.
2020-08-31T16:43:44.525Z,1598892224.525 [CBIT](DEBUG): Deactivating emergency mode.
2020-08-31T16:43:44.534Z,1598892224.534 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5378
2020-08-31T16:43:44.537Z,1598892224.537 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-08-31T16:43:44.537Z,1598892224.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-08-31T16:43:44.537Z,1598892224.537 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-08-31T16:43:44.537Z,1598892224.537 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-08-31T16:43:44.538Z,1598892224.538 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-08-31T16:43:44.538Z,1598892224.538 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-08-31T16:43:44.538Z,1598892224.538 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-08-31T16:43:44.538Z,1598892224.538 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-08-31T16:43:44.538Z,1598892224.538 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-08-31T16:43:44.538Z,1598892224.538 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-08-31T16:43:44.539Z,1598892224.539 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-08-31T16:43:44.539Z,1598892224.539 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-08-31T16:43:44.539Z,1598892224.539 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-08-31T16:43:44.539Z,1598892224.539 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-08-31T16:43:44.539Z,1598892224.539 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-08-31T16:43:44.539Z,1598892224.539 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-08-31T16:43:44.565Z,1598892224.565 [CBIT](DEBUG): Backplane powered.
2020-08-31T16:43:44.567Z,1598892224.567 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-08-31T16:43:44.578Z,1598892224.578 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-31T16:43:44.582Z,1598892224.582 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5376
2020-08-31T16:43:44.582Z,1598892224.582 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2020-08-31T16:43:44.612Z,1598892224.612 [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>


2020-08-31T16:43:44.614Z,1598892224.614 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2020-08-31T16:43:44.686Z,1598892224.686 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2020-08-31T16:43:44.687Z,1598892224.687 [Default:A.Wait](DEBUG): Construct Wait.
2020-08-31T16:43:44.688Z,1598892224.688 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-08-31T16:43:44.708Z,1598892224.708 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-08-31T16:43:44.733Z,1598892224.733 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-08-31T16:43:44.754Z,1598892224.754 [Default:E.Execute](DEBUG): Construct Execute.
2020-08-31T16:43:44.758Z,1598892224.758 [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>


2020-08-31T16:43:44.777Z,1598892224.777 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,RDI_Pathfinder,DAT,BPC1,AMEcho,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-08-31T16:43:44.782Z,1598892224.782 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-08-31T16:43:44.815Z,1598892224.815 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar
2020-08-31T16:43:44.824Z,1598892224.824 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2020-08-31T16:43:44.824Z,1598892224.824 [DAT](INFO): Powering up
2020-08-31T16:43:44.825Z,1598892224.825 [DAT](DEBUG): Initializing DAT.
2020-08-31T16:43:44.882Z,1598892224.882 [AMEcho](INFO): Powering up
2020-08-31T16:43:44.886Z,1598892224.886 [Radio_Surface](INFO): Powering up
2020-08-31T16:43:44.898Z,1598892224.898 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-08-31T16:43:44.902Z,1598892224.902 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2020-08-31T16:43:44.948Z,1598892224.948 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-08-31T16:43:44.958Z,1598892224.958 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-08-31T16:43:44.960Z,1598892224.960 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-08-31T16:43:44.970Z,1598892224.970 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-08-31T16:43:44.971Z,1598892224.971 [MassServo](DEBUG): Initializing EZServoServo.
2020-08-31T16:43:44.982Z,1598892224.982 [MassServo](DEBUG): Initializing MassServo.
2020-08-31T16:43:44.983Z,1598892224.983 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-31T16:43:44.994Z,1598892224.994 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-31T16:43:44.995Z,1598892224.995 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-08-31T16:43:45.006Z,1598892225.006 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-08-31T16:43:45.008Z,1598892225.008 [CommandLine](FAULT): Scheduling is paused
2020-08-31T16:43:45.009Z,1598892225.009 [CBIT](INFO): Critical error at 20200831T164344
2020-08-31T16:43:45.009Z,1598892225.009 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2020-08-31T16:43:45.373Z,1598892225.373 [AMEcho](INFO): Powering down
2020-08-31T16:43:45.378Z,1598892225.378 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-08-31T16:43:45.594Z,1598892225.594 [DepthRateCalculator](ERROR): Depth measurement is not active
2020-08-31T16:43:45.901Z,1598892225.901 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-08-31T16:43:45.901Z,1598892225.901 [RudderServo](FAULT): Rudder failed to initialize
2020-08-31T16:43:45.902Z,1598892225.902 [RudderServo] Communications Fault, FailCount= 1
2020-08-31T16:43:45.902Z,1598892225.902 [RudderServo](ERROR): Communications Fault
2020-08-31T16:43:46.013Z,1598892226.013 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-08-31T16:43:46.170Z,1598892226.170 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-31T16:43:46.171Z,1598892226.171 [RudderServo](INFO): Powering down
2020-08-31T16:43:46.850Z,1598892226.850 [RudderServo](DEBUG): Initializing EZServoServo.
2020-08-31T16:43:46.970Z,1598892226.970 [RudderServo](DEBUG): Initializing RudderServo.
2020-08-31T16:43:46.974Z,1598892226.974 [CBIT](INFO): Clearing failed state for component RudderServo
2020-08-31T16:43:46.974Z,1598892226.974 [RudderServo] No Fault, FailCount= 1
2020-08-31T16:43:57.359Z,1598892237.359 [DAT](INFO): commRate: 800
2020-08-31T16:43:57.360Z,1598892237.360 [DAT](INFO): commRate: 800
2020-08-31T16:43:57.744Z,1598892237.744 [DAT](INFO): entering command mode
2020-08-31T16:43:58.147Z,1598892238.147 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:43:58.563Z,1598892238.563 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:43:58.955Z,1598892238.955 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:43:59.360Z,1598892239.360 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:43:59.811Z,1598892239.811 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:00.167Z,1598892240.167 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:00.572Z,1598892240.572 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:00.987Z,1598892240.987 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:01.379Z,1598892241.379 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:01.784Z,1598892241.784 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:02.199Z,1598892242.199 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:02.602Z,1598892242.602 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:02.995Z,1598892242.995 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:03.411Z,1598892243.411 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:03.803Z,1598892243.803 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:04.208Z,1598892244.208 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:04.623Z,1598892244.623 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:05.015Z,1598892245.015 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:05.464Z,1598892245.464 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:05.823Z,1598892245.823 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:06.227Z,1598892246.227 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:06.671Z,1598892246.671 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:07.035Z,1598892247.035 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:07.450Z,1598892247.450 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:07.848Z,1598892247.848 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:08.247Z,1598892248.247 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:08.662Z,1598892248.662 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:09.055Z,1598892249.055 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:09.464Z,1598892249.464 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:09.902Z,1598892249.902 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:10.284Z,1598892250.284 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:10.676Z,1598892250.676 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:11.098Z,1598892251.098 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:11.479Z,1598892251.479 [NAL9602](INFO): Powering up NAL9602
2020-08-31T16:44:11.510Z,1598892251.510 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:11.883Z,1598892251.883 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:12.287Z,1598892252.287 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:12.721Z,1598892252.721 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:13.095Z,1598892253.095 [DAT](DEBUG): checking for command mode acknowledgment
2020-08-31T16:44:13.096Z,1598892253.096 [DAT](FAULT): failed to enter command mode
2020-08-31T16:44:13.511Z,1598892253.511 [DAT](INFO): entering command mode
2020-08-31T16:44:13.913Z,1598892253.913 [DAT](INFO): setting verbose to 3
2020-08-31T16:44:14.332Z,1598892254.332 [DAT](INFO): set verbose to 3
2020-08-31T16:44:14.332Z,1598892254.332 [DAT](INFO): setting DatVerbose to 27440
2020-08-31T16:44:14.736Z,1598892254.736 [DAT](INFO): set DatVerbose to 27440
2020-08-31T16:44:14.736Z,1598892254.736 [DAT](INFO): setting transmit power to 8
2020-08-31T16:44:15.125Z,1598892255.125 [DAT](INFO): set transmit power to 8
2020-08-31T16:44:15.125Z,1598892255.125 [DAT](INFO): setting local address to 9
2020-08-31T16:44:15.540Z,1598892255.540 [DAT](INFO): set local address to 9
2020-08-31T16:44:22.387Z,1598892262.387 [NAL9602](INFO): NAL9602 initialized
2020-08-31T16:44:44.611Z,1598892284.611 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-08-31T16:44:49.880Z,1598892289.880 [SBIT](IMPORTANT): Beginning Startup BIT
2020-08-31T16:44:49.884Z,1598892289.884 [CBIT](IMPORTANT): Beginning ground fault scan
2020-08-31T16:45:00.917Z,1598892300.917 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.011540
CHAN A1 (24V): -0.001222
CHAN A2 (12V): -0.007318
CHAN A3 (5V): -0.002410
CHAN B0 (3.3V): 0.000001
CHAN B1 (3.15aV): 0.000027
CHAN B2 (3.15bV): 0.000487
CHAN B3 (GND): 0.002248
OPEN: 0.005521
Full Scale Calc: 4.765 mA, -1.589 mA
2020-08-31T16:45:02.811Z,1598892302.811 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005180
2020-08-31T16:45:08.109Z,1598892308.109 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T16:45:43.636Z,1598892343.636 [SBIT](IMPORTANT): SBIT PASSED
2020-08-31T16:45:43.636Z,1598892343.636 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-08-31T16:45:43.637Z,1598892343.637 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere;

2020-08-31T16:45:43.637Z,1598892343.637 [SBIT](IMPORTANT): DAT.sbdAddress=6 enum;

2020-08-31T16:45:43.637Z,1598892343.637 [SBIT](IMPORTANT): DAT.surfaceThreshold=-1 meter;

2020-08-31T16:45:43.637Z,1598892343.637 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent;

2020-08-31T16:45:43.637Z,1598892343.637 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second;

2020-08-31T16:45:43.638Z,1598892343.638 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2020-08-31T16:45:43.638Z,1598892343.638 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=344.685708 cubic_centimeter;

2020-08-31T16:45:43.638Z,1598892343.638 [SBIT](IMPORTANT): VerticalControl.massDefault=11.293600 millimeter;

2020-08-31T16:45:43.638Z,1598892343.638 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool;

2020-08-31T16:45:44.029Z,1598892344.029 [MissionManager](IMPORTANT): Started mission Startup
2020-08-31T16:45:44.029Z,1598892344.029 [Startup] Running Loop=1
2020-08-31T16:45:44.030Z,1598892344.030 [Startup](DEBUG): Aggregate::initialize Startup
2020-08-31T16:45:44.030Z,1598892344.030 [Startup:A.GoToSurface] Running Loop=1
2020-08-31T16:45:44.030Z,1598892344.030 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-31T16:45:44.030Z,1598892344.030 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-31T16:45:44.031Z,1598892344.031 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-31T16:45:44.031Z,1598892344.031 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-31T16:45:44.031Z,1598892344.031 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-31T16:45:44.032Z,1598892344.032 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-31T16:45:44.033Z,1598892344.033 [Startup:StartupSatComms] Running Loop=1
2020-08-31T16:45:44.033Z,1598892344.033 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-08-31T16:45:44.034Z,1598892344.034 [Startup:StartupSatComms:A] Running Loop=1
2020-08-31T16:45:44.513Z,1598892344.513 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-08-31T16:46:40.654Z,1598892400.654 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T16:46:44.211Z,1598892404.211 [Startup:StartupSatComms:A](INFO): Timed out from 2020-08-31T16:45:44.0Z
2020-08-31T16:46:44.211Z,1598892404.211 [Startup:StartupSatComms:A] Stopped
2020-08-31T16:46:44.211Z,1598892404.211 [Startup:StartupSatComms:B] Running Loop=1
2020-08-31T16:46:44.668Z,1598892404.668 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-08-31T16:46:44.668Z,1598892404.668 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-31T16:46:44.674Z,1598892404.674 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-08-31T16:46:44.715Z,1598892404.715 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-31T16:46:45.188Z,1598892405.188 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2020-08-31T16:46:45.220Z,1598892405.220 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-31T16:46:45.220Z,1598892405.220 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-08-31T16:46:45.600Z,1598892405.600 [DAT](INFO): setting remote address to 6
2020-08-31T16:46:45.973Z,1598892405.973 [DAT](INFO): set remote address to 6
2020-08-31T16:46:45.974Z,1598892405.974 [DAT](INFO): entering online mode
2020-08-31T16:46:46.392Z,1598892406.392 [DAT](INFO): commRate: 800
2020-08-31T16:46:46.392Z,1598892406.392 [DAT](INFO): online mode acknowledged
2020-08-31T16:46:46.393Z,1598892406.393 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2020-08-31T16:46:47.193Z,1598892407.193 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200831T162726/Courier0007.lzma
2020-08-31T16:46:48.171Z,1598892408.171 [DataOverHttps](INFO): Moved sent file to Logs/20200831T162726/Courier0007.lzma.bak
2020-08-31T16:46:48.171Z,1598892408.171 [DataOverHttps](INFO): SBD MOMSN=12625620
2020-08-31T16:46:49.659Z,1598892409.659 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2020-08-31T16:47:04.021Z,1598892424.021 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20200831T164333/Courier0000.lzma
2020-08-31T16:47:05.023Z,1598892425.023 [DataOverHttps](INFO): Moved sent file to Logs/20200831T164333/Courier0000.lzma.bak
2020-08-31T16:47:05.023Z,1598892425.023 [DataOverHttps](INFO): SBD MOMSN=12625622
2020-08-31T16:47:06.580Z,1598892426.580 [DAT](FAULT): Ack receipt timeout failure.
2020-08-31T16:47:06.580Z,1598892426.580 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2020-08-31T16:47:07.003Z,1598892427.003 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2020-08-31T16:47:07.011Z,1598892427.011 [Startup:StartupSatComms:B] Stopped
2020-08-31T16:47:07.011Z,1598892427.011 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-08-31T16:47:07.011Z,1598892427.011 [Startup:StartupSatComms] Stopped
2020-08-31T16:47:07.011Z,1598892427.011 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-08-31T16:47:07.012Z,1598892427.012 [Startup](INFO): Completed Startup
2020-08-31T16:47:07.012Z,1598892427.012 [MissionManager](INFO): Startup is completed.
2020-08-31T16:47:07.012Z,1598892427.012 [MissionManager](INFO): Uninitializing Mission Startup
2020-08-31T16:47:07.012Z,1598892427.012 [Startup] Stopped
2020-08-31T16:47:07.012Z,1598892427.012 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-08-31T16:47:07.012Z,1598892427.012 [Startup:A.GoToSurface] Stopped
2020-08-31T16:47:07.012Z,1598892427.012 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-31T16:47:07.417Z,1598892427.417 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2020-08-31T16:47:07.466Z,1598892427.466 [MissionManager](IMPORTANT): Started mission Default
2020-08-31T16:47:07.466Z,1598892427.466 [Default] Running Loop=1
2020-08-31T16:47:07.466Z,1598892427.466 [Default](DEBUG): Aggregate::initialize Default
2020-08-31T16:47:07.466Z,1598892427.466 [Default:B.GoToSurface] Running Loop=1
2020-08-31T16:47:07.466Z,1598892427.466 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-31T16:47:07.466Z,1598892427.466 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-31T16:47:07.467Z,1598892427.467 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-31T16:47:07.467Z,1598892427.467 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-31T16:47:07.467Z,1598892427.467 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-31T16:47:07.468Z,1598892427.468 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-31T16:47:07.468Z,1598892427.468 [Default:A.Wait] Running Loop=1
2020-08-31T16:47:07.468Z,1598892427.468 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-08-31T16:47:10.644Z,1598892430.644 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2020-08-31T16:47:10.818Z,1598892430.818 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T16:47:20.739Z,1598892440.739 [Default:A.Wait](INFO): Done Waiting.
2020-08-31T16:47:20.739Z,1598892440.739 [Default:A.Wait] Stopped
2020-08-31T16:47:20.739Z,1598892440.739 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-08-31T16:47:21.135Z,1598892441.135 [Default:CheckIn] Running Loop=1
2020-08-31T16:47:21.135Z,1598892441.135 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-08-31T16:47:21.135Z,1598892441.135 [Default:CheckIn:Read_GPS] Running Loop=1
2020-08-31T16:47:21.551Z,1598892441.551 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-08-31T16:47:22.395Z,1598892442.395 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T16:47:27.605Z,1598892447.605 [DAT](FAULT): Ack receipt timeout failure.
2020-08-31T16:47:27.605Z,1598892447.605 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2020-08-31T16:47:27.988Z,1598892447.988 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2020-08-31T16:47:28.426Z,1598892448.426 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2020-08-31T16:47:31.641Z,1598892451.641 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2020-08-31T16:47:48.165Z,1598892468.165 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20200831T162726/Express0008.lzma
2020-08-31T16:47:48.615Z,1598892468.615 [DAT](FAULT): Ack receipt timeout failure.
2020-08-31T16:47:48.615Z,1598892468.615 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2020-08-31T16:47:49.004Z,1598892469.004 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2020-08-31T16:47:49.167Z,1598892469.167 [DataOverHttps](INFO): Moved sent file to Logs/20200831T162726/Express0008.lzma.bak
2020-08-31T16:47:49.167Z,1598892469.167 [DataOverHttps](INFO): SBD MOMSN=12625626
2020-08-31T16:47:49.415Z,1598892469.415 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2020-08-31T16:47:52.649Z,1598892472.649 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2020-08-31T16:47:53.909Z,1598892473.909 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T16:48:09.608Z,1598892489.608 [DAT](FAULT): Ack receipt timeout failure.
2020-08-31T16:48:09.608Z,1598892489.608 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2020-08-31T16:48:10.032Z,1598892490.032 [DAT](DEBUG): In sendingVerified, sbd done so set commsState_ = SENDING_FILL_BUFFER
2020-08-31T16:48:37.587Z,1598892517.587 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T16:48:54.934Z,1598892534.934 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T16:48:56.438Z,1598892536.438 [CommandLine](IMPORTANT): got command strobe off
2020-08-31T16:48:56.438Z,1598892536.438 [CommandLine](IMPORTANT): Deactivating strobe
2020-08-31T16:49:06.217Z,1598892546.217 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T16:49:25.551Z,1598892565.551 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-08-31T16:49:42.790Z,1598892582.790 [CommandLine](IMPORTANT): got command get 
2020-08-31T16:49:42.790Z,1598892582.790 [CommandLine](FAULT): Incomplete syntax. Try: help get
2020-08-31T16:49:45.787Z,1598892585.787 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-08-31T16:49:45.787Z,1598892585.787 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-31T16:49:45.797Z,1598892585.797 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-31T16:49:46.202Z,1598892586.202 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-31T16:49:46.202Z,1598892586.202 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-08-31T16:50:08.303Z,1598892608.303 [CommandLine](IMPORTANT): got command show variable stop
2020-08-31T16:50:08.511Z,1598892608.511 [CommandLine](IMPORTANT): CBIT.stopDepth (meter)
2020-08-31T16:50:08.526Z,1598892608.526 [CommandLine](IMPORTANT): ESPComponent.stopResultTimeout (minute)
2020-08-31T16:50:08.555Z,1598892608.555 [CommandLine](IMPORTANT): VerticalControl.stopDepthExcursion (meter)
2020-08-31T16:50:08.555Z,1598892608.555 [CommandLine](IMPORTANT): VerticalControl.stopOverrideDelay (minute)
2020-08-31T16:50:08.556Z,1598892608.556 [CommandLine](IMPORTANT): VerticalControl.stopOverrideDelayBuoy (minute)
2020-08-31T16:50:21.801Z,1598892621.801 [CommandLine](IMPORTANT): got command get CBIT.stopDepth
2020-08-31T16:50:21.802Z,1598892621.802 [CommandLine](IMPORTANT): CBIT.stopDepth 215.000000 m
2020-08-31T16:50:32.051Z,1598892632.051 [CommandLine](IMPORTANT): got command get CBIT.abortDepth
2020-08-31T16:50:32.052Z,1598892632.052 [CommandLine](IMPORTANT): CBIT.abortDepth 255.000000 m
2020-08-31T16:50:50.075Z,1598892650.075 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2020-08-31T16:51:34.603Z,1598892694.603 [CommandLine](IMPORTANT): got command get VerticalControl.buoyancyNeutral
2020-08-31T16:51:34.604Z,1598892694.604 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral 344.685699 cc
2020-08-31T16:51:54.756Z,1598892714.756 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2020-08-31T16:52:00.624Z,1598892720.624 [CommandLine](IMPORTANT): got command get VerticalControl.massDefault
2020-08-31T16:52:00.625Z,1598892720.625 [CommandLine](IMPORTANT): VerticalControl.massDefault 1.129360 cm
2020-08-31T16:52:21.366Z,1598892741.366 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-08-31T16:47:21.1Z
2020-08-31T16:52:21.367Z,1598892741.367 [Default:CheckIn:Read_GPS] Stopped
2020-08-31T16:52:21.367Z,1598892741.367 [Default:CheckIn:Read_Iridium] Running Loop=1
2020-08-31T16:52:21.763Z,1598892741.763 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-08-31T16:52:22.109Z,1598892742.109 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2020-08-31T16:52:22.534Z,1598892742.534 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2020-08-31T16:52:24.611Z,1598892744.611 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-08-31T16:52:24.630Z,1598892744.630 [BPC1](INFO): Received data from all battery sticks.
2020-08-31T16:52:25.780Z,1598892745.780 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2020-08-31T16:52:29.296Z,1598892749.296 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200831T164333/Courier0004.lzma
2020-08-31T16:52:30.291Z,1598892750.291 [DataOverHttps](INFO): Moved sent file to Logs/20200831T164333/Courier0004.lzma.bak
2020-08-31T16:52:30.291Z,1598892750.291 [DataOverHttps](INFO): SBD MOMSN=12625631
2020-08-31T16:52:33.247Z,1598892753.247 [CommandLine](IMPORTANT): got command get VerticalControl.massPositionLimitFwd
2020-08-31T16:52:33.248Z,1598892753.248 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitFwd 40.000000 mm
2020-08-31T16:52:40.722Z,1598892760.722 [CommandLine](IMPORTANT): got command get VerticalControl.massPositionLimitAft
2020-08-31T16:52:40.723Z,1598892760.723 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitAft -20.000000 mm
2020-08-31T16:52:42.729Z,1598892762.729 [DAT](FAULT): Ack receipt timeout failure.
2020-08-31T16:52:42.729Z,1598892762.729 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2020-08-31T16:52:43.108Z,1598892763.108 [DAT](INFO): Sent 39 bytes from file Logs/20200831T164333/Courier0004.lzma.parts
2020-08-31T16:52:43.108Z,1598892763.108 [DAT](INFO): Packets left to send: 0
2020-08-31T16:52:43.119Z,1598892763.119 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2020-08-31T16:52:43.542Z,1598892763.542 [Default:CheckIn:Read_Iridium] Stopped
2020-08-31T16:52:43.543Z,1598892763.543 [Default:CheckIn:C.Wait] Running Loop=1
2020-08-31T16:52:43.543Z,1598892763.543 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-08-31T16:52:46.770Z,1598892766.770 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-08-31T16:52:46.770Z,1598892766.770 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-31T16:52:46.806Z,1598892766.806 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-31T16:52:47.147Z,1598892767.147 [DataOverHttps](INFO): Sending 1021 bytes from file Logs/20200831T164333/Express0001.lzma
2020-08-31T16:52:47.220Z,1598892767.220 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-31T16:52:47.220Z,1598892767.220 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-08-31T16:52:48.147Z,1598892768.147 [DataOverHttps](INFO): Moved sent file to Logs/20200831T164333/Express0001.lzma.bak
2020-08-31T16:52:48.147Z,1598892768.147 [DataOverHttps](INFO): SBD MOMSN=12625633
2020-08-31T16:52:59.876Z,1598892779.876 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2020-08-31T16:52:59.876Z,1598892779.876 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2020-08-31T16:53:00.075Z,1598892780.075 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2020-08-31T16:53:00.078Z,1598892780.078 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min
2020-08-31T16:53:00.081Z,1598892780.081 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2020-08-31T16:53:00.132Z,1598892780.132 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2020-08-31T16:53:00.154Z,1598892780.154 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2020-08-31T16:53:00.161Z,1598892780.161 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2020-08-31T16:53:00.165Z,1598892780.165 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2020-08-31T16:53:00.180Z,1598892780.180 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2020-08-31T16:53:00.183Z,1598892780.183 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2020-08-31T16:53:00.194Z,1598892780.194 [MissionManager](INFO): DefineArg Science.PeakDetectFDOMActive = 0 bool
2020-08-31T16:53:00.199Z,1598892780.199 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2020-08-31T16:53:00.203Z,1598892780.203 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 bool
2020-08-31T16:53:00.207Z,1598892780.207 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 0.000000 bool
2020-08-31T16:53:00.218Z,1598892780.218 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 1.000000 bool
2020-08-31T16:53:00.234Z,1598892780.234 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2020-08-31T16:53:00.242Z,1598892780.242 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2020-08-31T16:53:00.250Z,1598892780.250 [MissionManager](INFO): DefineArg Science.EnabledWetLabsUBAT = 0.000000 bool
2020-08-31T16:53:00.253Z,1598892780.253 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2020-08-31T16:53:00.283Z,1598892780.283 [MissionManager](INFO): DefineArg Science.MedianFilterLen = 5.000000 count
2020-08-31T16:53:00.290Z,1598892780.290 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2020-08-31T16:53:00.298Z,1598892780.298 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2020-08-31T16:53:00.301Z,1598892780.301 [MissionManager](INFO): DefineArg Science.PeakShallowBound = nan m
2020-08-31T16:53:00.316Z,1598892780.316 [MissionManager](INFO): DefineArg Science.PeakDeepBound = nan m
2020-08-31T16:53:00.321Z,1598892780.321 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2020-08-31T16:53:00.332Z,1598892780.332 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2020-08-31T16:53:00.351Z,1598892780.351 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2020-08-31T16:53:00.354Z,1598892780.354 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2020-08-31T16:53:00.362Z,1598892780.362 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2020-08-31T16:53:00.365Z,1598892780.365 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2020-08-31T16:53:00.380Z,1598892780.380 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2020-08-31T16:53:00.388Z,1598892780.388 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2020-08-31T16:53:00.392Z,1598892780.392 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2020-08-31T16:53:00.411Z,1598892780.411 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2020-08-31T16:53:00.419Z,1598892780.419 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2020-08-31T16:53:00.423Z,1598892780.423 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2020-08-31T16:53:00.442Z,1598892780.442 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2020-08-31T16:53:00.449Z,1598892780.449 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2020-08-31T16:53:00.453Z,1598892780.453 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2020-08-31T16:53:00.460Z,1598892780.460 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2020-08-31T16:53:00.503Z,1598892780.503 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2020-08-31T16:53:00.511Z,1598892780.511 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2020-08-31T16:53:00.529Z,1598892780.529 [MissionManager](INFO): DefineOutput Science.PeakFDOM = 0.000000 ppb
2020-08-31T16:53:00.549Z,1598892780.549 [MissionManager](INFO): DefineOutput Science.PeakFDOMDepth = 0.000000 m
2020-08-31T16:53:00.564Z,1598892780.564 [MissionManager](INFO): DefineOutput Science.PeakFDOMLatitude = nan arcdeg
2020-08-31T16:53:00.582Z,1598892780.582 [MissionManager](INFO): DefineOutput Science.PeakFDOMLongitude = nan arcdeg
2020-08-31T16:53:00.594Z,1598892780.594 [MissionManager](INFO): DefineOutput Science.PatchFDOMDistance = nan m
2020-08-31T16:53:00.731Z,1598892780.731 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-08-31T16:53:00.759Z,1598892780.759 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2020-08-31T16:53:00.808Z,1598892780.808 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-08-31T16:53:00.854Z,1598892780.854 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-08-31T16:53:00.869Z,1598892780.869 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-08-31T16:53:01.014Z,1598892781.014 [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="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="TimeWindowPeakReport"><Description>
        If greater than zero, report a peak every window. If NaN or zero, this
        variable is ignored.
    </Description><Units:minute/><Value>NaN</Value></DefineArg>

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

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

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

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

    <DefineArg Name="OffPeakFractionHorizontal"><Description>
        When filtered horizontal value is this fraction of the peak, consider it
        outside the patch.
    </Description><Units:percent/><Value>80</Value></DefineArg>

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

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

    <DefineArg Name="PeakDetectFDOMActive"><Description>
        Turns on peak detection of concentration_of_chromophoric_dissolved_organic_matter_in_sea_water from FDOM sensor.
    </Description><False/></DefineArg>
    
    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

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

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

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

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

    <DefineArg Name="EnabledWetLabsSeaOWL_UV_A"><Description>
        Automatically set to true if the the WetLabs SeaOWL UV-A is enabled. Set
        to false to disable the WetLabs SeaOWL UV-A.
    </Description><Science:WetLabsSeaOWL_UV_A.loadAtStartup/></DefineArg>

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

    <DefineArg Name="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="MedianFilterLen"><Description>
        Median filter length (only for chlorophyll fluorescence which tends to have spikes)
    </Description><Units:count/><Value>5</Value></DefineArg>

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

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

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

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

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

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

    <DefineOutput Name="PeakChlTemperature"><Units:celsius/><Value>0</Value></DefineOutput>

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

    <DefineOutput Name="PeakFDOMLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>
    
    <DefineOutput Name="PatchFDOMDistance"><Units:meter/><Value>NaN</Value></DefineOutput>    
    
    <Parallel/>

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

    <ReadData 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="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

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

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

    <Aggregate Id="OceanCurrent">
        <Estimation:CurrentEstimator>
            <Parallel/>
        </Estimation:CurrentEstimator>	
    </Aggregate>    	

    <Aggregate Id="PeakDetectChl">

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

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

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

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

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

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

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

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

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

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

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

    </Aggregate>

    <Aggregate Id="PeakDetectOil">

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

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

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

    </Aggregate>

    <Aggregate Id="PeakDetectFDOM">

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

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

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

    </Aggregate>

</Aggregate>


2020-08-31T16:53:01.017Z,1598892781.017 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2020-08-31T16:53:01.306Z,1598892781.306 [Default] Stopped
2020-08-31T16:53:01.306Z,1598892781.306 [Default](DEBUG): Aggregate::uninitialize Default
2020-08-31T16:53:01.307Z,1598892781.307 [Default:B.GoToSurface] Stopped
2020-08-31T16:53:01.307Z,1598892781.307 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-31T16:53:01.307Z,1598892781.307 [Default:CheckIn] Stopped
2020-08-31T16:53:01.307Z,1598892781.307 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-08-31T16:53:01.307Z,1598892781.307 [Default:CheckIn:C.Wait] Stopped
2020-08-31T16:53:01.307Z,1598892781.307 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-08-31T16:53:01.307Z,1598892781.307 [MissionManager](IMPORTANT): Started mission Science
2020-08-31T16:53:01.307Z,1598892781.307 [Science] Running Loop=1
2020-08-31T16:53:01.307Z,1598892781.307 [Science](DEBUG): Aggregate::initialize Science
2020-08-31T16:53:01.307Z,1598892781.307 [Science:A] Running Loop=1
2020-08-31T16:53:01.307Z,1598892781.307 [Science:B] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:C] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:D] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:E] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:F] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:Read_Oil] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:PeakDetectChl] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2020-08-31T16:53:01.308Z,1598892781.308 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2020-08-31T16:53:01.308Z,1598892781.308 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-08-31T16:53:01.310Z,1598892781.310 [Science:HighestChlPeakReport] Running Loop=1
2020-08-31T16:53:01.310Z,1598892781.310 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2020-08-31T16:53:01.311Z,1598892781.311 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2020-08-31T16:53:01.311Z,1598892781.311 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2020-08-31T16:53:01.311Z,1598892781.311 [Science:PeakDetectNO3] Running Loop=1
2020-08-31T16:53:01.311Z,1598892781.311 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2020-08-31T16:53:01.311Z,1598892781.311 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2020-08-31T16:53:01.311Z,1598892781.311 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-08-31T16:53:01.322Z,1598892781.322 [Science:PeakDetectOil] Running Loop=1
2020-08-31T16:53:01.322Z,1598892781.322 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2020-08-31T16:53:01.322Z,1598892781.322 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2020-08-31T16:53:01.322Z,1598892781.322 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-08-31T16:53:01.327Z,1598892781.327 [Science:PeakDetectFDOM] Running Loop=1
2020-08-31T16:53:01.327Z,1598892781.327 [Science:PeakDetectFDOM](DEBUG): Aggregate::initialize Science:PeakDetectFDOM
2020-08-31T16:53:01.328Z,1598892781.328 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2020-08-31T16:53:01.328Z,1598892781.328 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-08-31T16:53:01.330Z,1598892781.330 [Science:OceanCurrent] Running Loop=1
2020-08-31T16:53:01.330Z,1598892781.330 [Science:OceanCurrent](DEBUG): Aggregate::initialize Science:OceanCurrent
2020-08-31T16:53:01.330Z,1598892781.330 [Science:OceanCurrent:A.] Running Loop=1
2020-08-31T16:53:01.330Z,1598892781.330 [Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2020-08-31T16:53:01.331Z,1598892781.331 [Science:PeakDetectFDOM] Stopped
2020-08-31T16:53:01.331Z,1598892781.331 [Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize Science:PeakDetectFDOM
2020-08-31T16:53:01.331Z,1598892781.331 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2020-08-31T16:53:01.331Z,1598892781.331 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectOil] Stopped
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectNO3] Stopped
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-08-31T16:53:01.332Z,1598892781.332 [Science:HighestChlPeakReport] Stopped
2020-08-31T16:53:01.332Z,1598892781.332 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2020-08-31T16:53:01.332Z,1598892781.332 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2020-08-31T16:53:01.332Z,1598892781.332 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2020-08-31T16:53:01.332Z,1598892781.332 [Science:PeakDetectChl] Stopped
2020-08-31T16:53:01.333Z,1598892781.333 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2020-08-31T16:53:01.333Z,1598892781.333 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2020-08-31T16:53:01.333Z,1598892781.333 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-08-31T16:53:01.333Z,1598892781.333 [Science:OceanCurrent:A.] Running Loop=1
2020-08-31T16:53:01.333Z,1598892781.333 [Science:Read_Oil] Stopped
2020-08-31T16:53:01.337Z,1598892781.337 [Science:F] Stopped
2020-08-31T16:53:01.337Z,1598892781.337 [Science:E] Running Loop=1
2020-08-31T16:53:01.338Z,1598892781.338 [Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2020-08-31T16:53:01.338Z,1598892781.338 [Science:D] Stopped
2020-08-31T16:53:01.338Z,1598892781.338 [Science:C] Running Loop=1
2020-08-31T16:53:01.339Z,1598892781.339 [Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2020-08-31T16:53:01.339Z,1598892781.339 [Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2020-08-31T16:53:01.339Z,1598892781.339 [Science:B] Running Loop=1
2020-08-31T16:53:01.340Z,1598892781.340 [Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2020-08-31T16:53:01.341Z,1598892781.341 [Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2020-08-31T16:53:01.341Z,1598892781.341 [Science:A] Stopped
2020-08-31T16:53:01.599Z,1598892781.599 [WetLabsBB2FL](INFO): Powering up
2020-08-31T16:53:04.919Z,1598892784.919 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2020-08-31T16:53:06.928Z,1598892786.928 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000538 psu
2020-08-31T16:53:07.931Z,1598892787.931 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000538 psu
2020-08-31T16:53:08.936Z,1598892788.936 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000497 psu
2020-08-31T16:53:09.939Z,1598892789.939 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000496 psu
2020-08-31T16:53:10.943Z,1598892790.943 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000497 psu
2020-08-31T16:53:11.951Z,1598892791.951 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000497 psu
2020-08-31T16:53:12.952Z,1598892792.952 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000497 psu
2020-08-31T16:53:13.955Z,1598892793.955 [CTD_Seabird](ERROR): Salinity reading out of range: 0.000497 psu
2020-08-31T16:53:14.307Z,1598892794.307 [CommandLine](IMPORTANT): got command stop
2020-08-31T16:53:14.307Z,1598892794.307 [CommandLine](IMPORTANT): Scheduling is paused
2020-08-31T16:53:14.308Z,1598892794.308 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2020-08-31T16:53:14.652Z,1598892794.652 [MissionManager](INFO): MissionManager is completed.
2020-08-31T16:53:14.652Z,1598892794.652 [MissionManager](INFO): Uninitializing Mission Science
2020-08-31T16:53:14.652Z,1598892794.652 [Science] Stopped
2020-08-31T16:53:14.652Z,1598892794.652 [Science](DEBUG): Aggregate::uninitialize Science
2020-08-31T16:53:14.652Z,1598892794.652 [Science:B] Stopped
2020-08-31T16:53:14.652Z,1598892794.652 [Science:C] Stopped
2020-08-31T16:53:14.652Z,1598892794.652 [Science:E] Stopped
2020-08-31T16:53:14.652Z,1598892794.652 [Science:OceanCurrent] Stopped
2020-08-31T16:53:14.652Z,1598892794.652 [Science:OceanCurrent](DEBUG): Aggregate::uninitialize Science:OceanCurrent
2020-08-31T16:53:14.652Z,1598892794.652 [Science:OceanCurrent:A.] Stopped
2020-08-31T16:53:14.798Z,1598892794.798 [WetLabsBB2FL](INFO): Powering down
2020-08-31T16:53:15.038Z,1598892795.038 [MissionManager](IMPORTANT): Started mission Default
2020-08-31T16:53:15.039Z,1598892795.039 [Default] Running Loop=1
2020-08-31T16:53:15.039Z,1598892795.039 [Default](DEBUG): Aggregate::initialize Default
2020-08-31T16:53:15.039Z,1598892795.039 [Default:B.GoToSurface] Running Loop=1
2020-08-31T16:53:15.039Z,1598892795.039 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-08-31T16:53:15.039Z,1598892795.039 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-08-31T16:53:15.039Z,1598892795.039 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-08-31T16:53:15.040Z,1598892795.040 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-08-31T16:53:15.040Z,1598892795.040 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-08-31T16:53:15.040Z,1598892795.040 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-08-31T16:53:15.041Z,1598892795.040 [Default:A.Wait] Running Loop=1
2020-08-31T16:53:15.041Z,1598892795.041 [Default:A.Wait](DEBUG): Initialize Wait Component.
2020-08-31T16:53:28.374Z,1598892808.374 [Default:A.Wait](INFO): Done Waiting.
2020-08-31T16:53:28.374Z,1598892808.374 [Default:A.Wait] Stopped
2020-08-31T16:53:28.374Z,1598892808.374 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2020-08-31T16:53:28.806Z,1598892808.806 [Default:CheckIn] Running Loop=1
2020-08-31T16:53:28.806Z,1598892808.806 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2020-08-31T16:53:28.806Z,1598892808.806 [Default:CheckIn:Read_GPS] Running Loop=1
2020-08-31T16:54:24.515Z,1598892864.515 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-08-31T16:54:24.515Z,1598892864.515 [NAL9602] Data Fault, FailCount= 1
2020-08-31T16:54:24.515Z,1598892864.515 [NAL9602](ERROR): Data Fault
2020-08-31T16:54:24.542Z,1598892864.542 [CBIT](ERROR): Data Fault in component: NAL9602
2020-08-31T16:54:24.920Z,1598892864.920 [NAL9602](INFO): Powering down
2020-08-31T16:54:25.743Z,1598892865.743 [CBIT](INFO): Clearing failed state for component NAL9602
2020-08-31T16:54:25.743Z,1598892865.743 [NAL9602] No Fault, FailCount= 1
2020-08-31T16:54:55.220Z,1598892895.220 [NAL9602](INFO): Powering up NAL9602
2020-08-31T16:55:06.124Z,1598892906.124 [NAL9602](INFO): NAL9602 initialized
2020-08-31T16:55:47.745Z,1598892947.745 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-08-31T16:55:47.746Z,1598892947.746 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-08-31T16:55:47.756Z,1598892947.756 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-08-31T16:55:48.177Z,1598892948.177 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-08-31T16:55:48.177Z,1598892948.177 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-08-31T16:58:00.523Z,1598893080.523 [CommandLine](IMPORTANT): got command restart system
2020-08-31T16:58:02.606Z,1598893082.606 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:02.606Z,1598893082.606 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:02.789Z,1598893082.789 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-08-31T16:58:02.790Z,1598893082.790 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:02.790Z,1598893082.790 [CommandLine](INFO): Join timeout helper Thread ID is 5429
2020-08-31T16:58:02.791Z,1598893082.791 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-08-31T16:58:02.791Z,1598893082.791 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:02.791Z,1598893082.791 [NavChartDb](INFO): Join timeout helper Thread ID is 5430
2020-08-31T16:58:02.830Z,1598893082.830 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:02.830Z,1598893082.830 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:02.849Z,1598893082.849 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2020-08-31T16:58:02.849Z,1598893082.849 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:02.850Z,1598893082.850 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5431
2020-08-31T16:58:03.102Z,1598893083.102 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:03.102Z,1598893083.102 [WetLabsBB2FL](INFO): Powering down
2020-08-31T16:58:03.103Z,1598893083.103 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.113Z,1598893083.113 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-08-31T16:58:03.114Z,1598893083.114 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.114Z,1598893083.114 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5432
2020-08-31T16:58:03.182Z,1598893083.182 [CTD_Seabird](INFO): Powering down
2020-08-31T16:58:03.193Z,1598893083.193 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:03.194Z,1598893083.194 [CTD_Seabird](INFO): Powering down
2020-08-31T16:58:03.205Z,1598893083.205 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.213Z,1598893083.213 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler
2020-08-31T16:58:03.213Z,1598893083.213 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.214Z,1598893083.214 [BackSeatDriver](INFO): Join timeout helper Thread ID is 5433
2020-08-31T16:58:03.581Z,1598893083.582 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:03.582Z,1598893083.582 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.586Z,1598893083.586 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-08-31T16:58:03.586Z,1598893083.586 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.587Z,1598893083.587 [Radio_Surface](INFO): Join timeout helper Thread ID is 5434
2020-08-31T16:58:03.841Z,1598893083.841 [Radio_Surface](INFO): Powering down
2020-08-31T16:58:03.842Z,1598893083.842 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:03.843Z,1598893083.843 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.846Z,1598893083.846 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-08-31T16:58:03.846Z,1598893083.846 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:03.847Z,1598893083.847 [Onboard](INFO): Join timeout helper Thread ID is 5435
2020-08-31T16:58:04.678Z,1598893084.678 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-08-31T16:58:05.174Z,1598893085.174 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:05.175Z,1598893085.175 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:05.194Z,1598893085.194 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-08-31T16:58:05.194Z,1598893085.194 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:05.195Z,1598893085.195 [DataOverHttps](INFO): Join timeout helper Thread ID is 5436
2020-08-31T16:58:05.682Z,1598893085.682 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:05.682Z,1598893085.682 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:05.698Z,1598893085.698 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-08-31T16:58:05.698Z,1598893085.698 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:05.699Z,1598893085.699 [logger](INFO): Join timeout helper Thread ID is 5437
2020-08-31T16:58:05.734Z,1598893085.734 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:05.734Z,1598893085.734 [logger ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:05.738Z,1598893085.738 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-08-31T16:58:05.738Z,1598893085.738 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:05.738Z,1598893085.738 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-08-31T16:58:05.738Z,1598893085.738 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:05.739Z,1598893085.739 [controlThread](INFO): Join timeout helper Thread ID is 5438
2020-08-31T16:58:05.890Z,1598893085.890 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-08-31T16:58:05.890Z,1598893085.890 [controlThread](DEBUG): Uninitializing ControlThread
2020-08-31T16:58:05.890Z,1598893085.890 [AHRS_M2](INFO): Powering down
2020-08-31T16:58:05.962Z,1598893085.962 [NAL9602](INFO): Powering down
2020-08-31T16:58:06.034Z,1598893086.034 [RDI_Pathfinder](INFO): Powering down
2020-08-31T16:58:06.035Z,1598893086.035 [DAT](INFO): Powering down
2020-08-31T16:58:06.154Z,1598893086.154 [AMEcho](INFO): Powering down
2020-08-31T16:58:06.155Z,1598893086.155 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-08-31T16:58:06.156Z,1598893086.156 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-08-31T16:58:06.156Z,1598893086.156 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-08-31T16:58:06.157Z,1598893086.157 [MissionManager](INFO): Uninitializing Mission Default
2020-08-31T16:58:06.157Z,1598893086.157 [Default] Stopped
2020-08-31T16:58:06.157Z,1598893086.157 [Default](DEBUG): Aggregate::uninitialize Default
2020-08-31T16:58:06.157Z,1598893086.157 [Default:B.GoToSurface] Stopped
2020-08-31T16:58:06.158Z,1598893086.158 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-08-31T16:58:06.158Z,1598893086.158 [Default:CheckIn] Stopped
2020-08-31T16:58:06.158Z,1598893086.158 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2020-08-31T16:58:06.158Z,1598893086.158 [Default:CheckIn:Read_GPS] Stopped
2020-08-31T16:58:06.161Z,1598893086.161 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-08-31T16:58:06.161Z,1598893086.161 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-08-31T16:58:06.161Z,1598893086.161 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-08-31T16:58:06.162Z,1598893086.162 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-08-31T16:58:06.162Z,1598893086.162 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-08-31T16:58:06.162Z,1598893086.162 [BuoyancyServo](INFO): Powering down
2020-08-31T16:58:06.173Z,1598893086.173 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-08-31T16:58:06.174Z,1598893086.174 [ElevatorServo](INFO): Powering down
2020-08-31T16:58:06.174Z,1598893086.174 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-08-31T16:58:06.175Z,1598893086.175 [MassServo](INFO): Powering down
2020-08-31T16:58:06.175Z,1598893086.175 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-08-31T16:58:06.176Z,1598893086.176 [RudderServo](INFO): Powering down
2020-08-31T16:58:06.176Z,1598893086.176 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-08-31T16:58:06.176Z,1598893086.176 [ThrusterServo](INFO): Powering down
2020-08-31T16:58:06.177Z,1598893086.178 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-08-31T16:58:06.178Z,1598893086.178 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-08-31T16:58:06.178Z,1598893086.178 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-08-31T16:58:06.178Z,1598893086.178 [CBIT](DEBUG): Powering off loads.
2020-08-31T16:58:06.189Z,1598893086.189 [CBIT](DEBUG): Disabling WDT.
2020-08-31T16:58:06.201Z,1598893086.201 [CBIT](DEBUG): Opening all GF detection circuits.
2020-08-31T16:58:06.202Z,1598893086.202 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.308Z,1598893086.308 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.311Z,1598893086.311 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.317Z,1598893086.317 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.376Z,1598893086.376 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.380Z,1598893086.380 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.383Z,1598893086.383 [BackSeatDriver ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.393Z,1598893086.393 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-08-31T16:58:06.456Z,1598893086.456 [logger ThreadHandler](INFO): Thread cancelled.