2022-03-04T15:58:22.214Z,1646409502.214 [Supervisor](DEBUG): Initializing supervisor.
2022-03-04T15:58:22.218Z,1646409502.218 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-03-04T15:58:22.219Z,1646409502.219 [SyncHandler](INFO): Protected caller Thread ID is 4277
2022-03-04T15:58:22.219Z,1646409502.219 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-03-04T15:58:22.220Z,1646409502.220 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-03-04T15:58:22.220Z,1646409502.220 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4278
2022-03-04T15:58:22.224Z,1646409502.224 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-03-04T15:58:22.242Z,1646409502.242 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-03-04T15:58:22.243Z,1646409502.243 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-03-04T15:58:22.244Z,1646409502.244 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4279
2022-03-04T15:58:22.248Z,1646409502.248 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-03-04T15:58:22.249Z,1646409502.249 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-03-04T15:58:22.249Z,1646409502.249 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4280
2022-03-04T15:58:22.251Z,1646409502.251 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-03-04T15:58:22.252Z,1646409502.252 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-03-04T15:58:22.253Z,1646409502.253 [logger ThreadHandler](INFO): Protected caller Thread ID is 4281
2022-03-04T15:58:22.257Z,1646409502.257 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-03-04T15:58:22.257Z,1646409502.257 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-03-04T15:58:22.259Z,1646409502.259 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-03-04T15:58:22.365Z,1646409502.365 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-03-04T15:58:22.365Z,1646409502.365 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-03-04T15:58:22.507Z,1646409502.507 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-03-04T15:58:22.507Z,1646409502.507 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-03-04T15:58:22.709Z,1646409502.709 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-03-04T15:58:22.709Z,1646409502.709 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-03-04T15:58:22.846Z,1646409502.846 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-03-04T15:58:22.847Z,1646409502.847 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-03-04T15:58:23.292Z,1646409503.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-03-04T15:58:23.293Z,1646409503.293 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-03-04T15:58:23.651Z,1646409503.651 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-03-04T15:58:23.652Z,1646409503.652 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-03-04T15:58:23.867Z,1646409503.867 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-03-04T15:58:23.868Z,1646409503.868 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-03-04T15:58:24.071Z,1646409504.071 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-03-04T15:58:24.071Z,1646409504.071 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-03-04T15:58:24.172Z,1646409504.172 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2022-03-04T15:58:24.173Z,1646409504.173 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-03-04T15:58:24.706Z,1646409504.706 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-03-04T15:58:24.707Z,1646409504.707 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-03-04T15:58:25.113Z,1646409505.113 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-03-04T15:58:25.114Z,1646409505.114 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-03-04T15:58:25.769Z,1646409505.769 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-03-04T15:58:25.770Z,1646409505.770 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-03-04T15:58:26.115Z,1646409506.115 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-03-04T15:58:26.115Z,1646409506.115 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-03-04T15:58:26.307Z,1646409506.307 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-03-04T15:58:26.308Z,1646409506.308 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-03-04T15:58:26.406Z,1646409506.406 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-03-04T15:58:26.407Z,1646409506.407 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-03-04T15:58:26.491Z,1646409506.491 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-stella/
2022-03-04T15:58:26.492Z,1646409506.492 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/workSite.cfg
2022-03-04T15:58:26.587Z,1646409506.587 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Dock.cfg
2022-03-04T15:58:26.674Z,1646409506.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/vehicle.cfg
2022-03-04T15:58:26.889Z,1646409506.889 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Servo.cfg
2022-03-04T15:58:27.004Z,1646409507.004 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Navigation.cfg
2022-03-04T15:58:27.116Z,1646409507.116 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/BIT.cfg
2022-03-04T15:58:27.214Z,1646409507.214 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Battery.cfg
2022-03-04T15:58:27.476Z,1646409507.476 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-03-04T15:58:27.477Z,1646409507.477 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Simulator.cfg
2022-03-04T15:58:27.563Z,1646409507.563 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Science.cfg
2022-03-04T15:58:27.694Z,1646409507.694 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Sensor.cfg
2022-03-04T15:58:27.878Z,1646409507.878 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/Control.cfg
2022-03-04T15:58:27.978Z,1646409507.978 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/logger.cfg
2022-03-04T15:58:28.077Z,1646409508.077 [Supervisor](INFO): Opening Config file at: Config/lrauv-stella/secure.cfg
2022-03-04T15:58:28.162Z,1646409508.162 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-03-04T15:58:28.177Z,1646409508.177 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-03-04T15:58:28.279Z,1646409508.279 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-03-04T15:58:28.280Z,1646409508.280 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-03-04T15:58:28.361Z,1646409508.361 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-03-04T15:58:28.361Z,1646409508.361 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-03-04T15:58:28.374Z,1646409508.374 [NavChart] Loaded
2022-03-04T15:58:28.374Z,1646409508.374 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-03-04T15:58:28.379Z,1646409508.379 [UniversalFixResidualReporter] Loaded
2022-03-04T15:58:28.380Z,1646409508.380 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-03-04T15:58:28.390Z,1646409508.390 [WorkSite] Loaded
2022-03-04T15:58:28.390Z,1646409508.390 [ComponentRegistry](DEBUG): SyncComponent "WorkSite" handled in the control thread.
2022-03-04T15:58:28.390Z,1646409508.390 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-03-04T15:58:28.391Z,1646409508.391 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-03-04T15:58:28.709Z,1646409508.709 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-03-04T15:58:28.709Z,1646409508.709 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-03-04T15:58:28.836Z,1646409508.836 [BuoyancyServo] Loaded
2022-03-04T15:58:28.837Z,1646409508.837 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-03-04T15:58:28.857Z,1646409508.857 [ElevatorServo] Loaded
2022-03-04T15:58:28.857Z,1646409508.857 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-03-04T15:58:28.877Z,1646409508.877 [MassServo] Loaded
2022-03-04T15:58:28.877Z,1646409508.877 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-03-04T15:58:28.897Z,1646409508.897 [RudderServo] Loaded
2022-03-04T15:58:28.897Z,1646409508.897 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-03-04T15:58:28.898Z,1646409508.898 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-03-04T15:58:28.898Z,1646409508.898 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-03-04T15:58:28.949Z,1646409508.949 [VerticalControl](DEBUG): Construct VerticalControl.
2022-03-04T15:58:29.006Z,1646409509.006 [VerticalControl] Loaded
2022-03-04T15:58:29.006Z,1646409509.006 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-03-04T15:58:29.009Z,1646409509.009 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-03-04T15:58:29.046Z,1646409509.046 [HorizontalControl] Loaded
2022-03-04T15:58:29.046Z,1646409509.046 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-03-04T15:58:29.048Z,1646409509.048 [SpeedControl](DEBUG): Construct SpeedControl.
2022-03-04T15:58:29.052Z,1646409509.052 [SpeedControl] Loaded
2022-03-04T15:58:29.052Z,1646409509.052 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-03-04T15:58:29.055Z,1646409509.055 [LoopControl](DEBUG): Construct LoopControl.
2022-03-04T15:58:29.055Z,1646409509.055 [LoopControl] Loaded
2022-03-04T15:58:29.055Z,1646409509.055 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-03-04T15:58:29.056Z,1646409509.056 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-03-04T15:58:29.056Z,1646409509.056 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-03-04T15:58:29.149Z,1646409509.149 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-03-04T15:58:29.150Z,1646409509.150 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-03-04T15:58:29.206Z,1646409509.206 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-03-04T15:58:29.207Z,1646409509.207 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-03-04T15:58:29.586Z,1646409509.586 [AHRS_M2] Loaded
2022-03-04T15:58:29.586Z,1646409509.586 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-03-04T15:58:29.587Z,1646409509.587 [Module Loader](CRITICAL): Could not find element BackseatComponent.loadAtStartup
2022-03-04T15:58:30.393Z,1646409510.393 [BPC1] Loaded
2022-03-04T15:58:30.393Z,1646409510.393 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-03-04T15:58:30.466Z,1646409510.466 [DataOverHttps] Loaded
2022-03-04T15:58:30.466Z,1646409510.466 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-03-04T15:58:30.467Z,1646409510.467 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409664E0
2022-03-04T15:58:30.467Z,1646409510.467 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4369
2022-03-04T15:58:30.487Z,1646409510.487 [Depth_Keller] Loaded
2022-03-04T15:58:30.488Z,1646409510.488 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-03-04T15:58:30.488Z,1646409510.488 [Module Loader](CRITICAL): Could not find element DepthKeller33X.loadAtStartup
2022-03-04T15:58:30.547Z,1646409510.547 [NAL9602] Loaded
2022-03-04T15:58:30.548Z,1646409510.548 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-03-04T15:58:30.548Z,1646409510.548 [Module Loader](CRITICAL): Could not find element NanoDVR.loadAtStartup
2022-03-04T15:58:30.577Z,1646409510.577 [Onboard] Loaded
2022-03-04T15:58:30.577Z,1646409510.577 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-03-04T15:58:30.578Z,1646409510.578 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409964E0
2022-03-04T15:58:30.579Z,1646409510.579 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4370
2022-03-04T15:58:30.579Z,1646409510.579 [Module Loader](CRITICAL): Could not find element Power24vConverter.loadAtStartup
2022-03-04T15:58:30.592Z,1646409510.592 [Radio_Surface] Loaded
2022-03-04T15:58:30.592Z,1646409510.592 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-03-04T15:58:30.593Z,1646409510.593 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409C64E0
2022-03-04T15:58:30.594Z,1646409510.594 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4371
2022-03-04T15:58:30.637Z,1646409510.637 [RDI_Pathfinder] Loaded
2022-03-04T15:58:30.638Z,1646409510.638 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2022-03-04T15:58:30.638Z,1646409510.638 [Module Loader](CRITICAL): Could not find element AMEcho.loadAtStartup
2022-03-04T15:58:30.639Z,1646409510.639 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-03-04T15:58:30.639Z,1646409510.639 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-03-04T15:58:30.650Z,1646409510.650 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-03-04T15:58:30.650Z,1646409510.650 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-03-04T15:58:30.677Z,1646409510.677 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-03-04T15:58:30.678Z,1646409510.678 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-03-04T15:58:30.720Z,1646409510.720 [DepthRateCalculator] Loaded
2022-03-04T15:58:30.720Z,1646409510.720 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-03-04T15:58:30.725Z,1646409510.725 [PitchRateCalculator] Loaded
2022-03-04T15:58:30.725Z,1646409510.725 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-03-04T15:58:30.734Z,1646409510.734 [SpeedCalculator] Loaded
2022-03-04T15:58:30.735Z,1646409510.735 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-03-04T15:58:30.748Z,1646409510.748 [TempGradientCalculator] Loaded
2022-03-04T15:58:30.749Z,1646409510.749 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2022-03-04T15:58:30.749Z,1646409510.749 [Module Loader](CRITICAL): Could not find element VerticalHomogeneityIndexCalculator.loadAtStartup
2022-03-04T15:58:30.753Z,1646409510.753 [YawRateCalculator] Loaded
2022-03-04T15:58:30.754Z,1646409510.754 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-03-04T15:58:30.772Z,1646409510.772 [ElevatorOffsetCalculator] Loaded
2022-03-04T15:58:30.772Z,1646409510.772 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-03-04T15:58:30.772Z,1646409510.772 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-03-04T15:58:30.773Z,1646409510.773 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-03-04T15:58:30.913Z,1646409510.913 [SBIT](DEBUG): Construct Startup Built In Test.
2022-03-04T15:58:30.922Z,1646409510.922 [SBIT] Loaded
2022-03-04T15:58:30.922Z,1646409510.922 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-03-04T15:58:30.925Z,1646409510.925 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-03-04T15:58:30.938Z,1646409510.938 [IBIT] Loaded
2022-03-04T15:58:30.938Z,1646409510.938 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-03-04T15:58:30.944Z,1646409510.944 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-03-04T15:58:31.045Z,1646409511.045 [CBIT] Loaded
2022-03-04T15:58:31.045Z,1646409511.045 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-03-04T15:58:31.046Z,1646409511.046 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-03-04T15:58:31.046Z,1646409511.046 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-03-04T15:58:31.177Z,1646409511.177 [PAR_Licor] Loaded
2022-03-04T15:58:31.178Z,1646409511.178 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-03-04T15:58:31.212Z,1646409511.212 [WetLabsSeaOWL_UV_A] Loaded
2022-03-04T15:58:31.212Z,1646409511.212 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2022-03-04T15:58:31.213Z,1646409511.213 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 40AE44E0
2022-03-04T15:58:31.213Z,1646409511.213 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 4372
2022-03-04T15:58:31.214Z,1646409511.214 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-03-04T15:58:31.220Z,1646409511.220 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-03-04T15:58:31.223Z,1646409511.223 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-03-04T15:58:31.234Z,1646409511.234 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-03-04T15:58:31.235Z,1646409511.235 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B144E0
2022-03-04T15:58:31.235Z,1646409511.235 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4373
2022-03-04T15:58:31.240Z,1646409511.240 [Supervisor](INFO): Main Thread ID is 4276
2022-03-04T15:58:31.240Z,1646409511.240 [Supervisor](DEBUG): Running supervisor.
2022-03-04T15:58:31.240Z,1646409511.240 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4374
2022-03-04T15:58:31.241Z,1646409511.241 [CommandExec](INFO): Initializing the command executive.
2022-03-04T15:58:31.242Z,1646409511.242 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4375
2022-03-04T15:58:31.244Z,1646409511.244 [controlThread ThreadHandler](INFO): Handler Thread ID is 4376
2022-03-04T15:58:31.245Z,1646409511.245 [controlThread](DEBUG): Initializing ControlThread
2022-03-04T15:58:31.246Z,1646409511.246 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-03-04T15:58:31.247Z,1646409511.247 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-03-04T15:58:31.247Z,1646409511.247 [WorkSite](DEBUG): Initializing WorkSite component.
2022-03-04T15:58:31.249Z,1646409511.249 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-03-04T15:58:31.250Z,1646409511.250 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-03-04T15:58:31.251Z,1646409511.251 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-03-04T15:58:31.252Z,1646409511.252 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-03-04T15:58:31.253Z,1646409511.253 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-03-04T15:58:31.254Z,1646409511.254 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-03-04T15:58:31.254Z,1646409511.254 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-03-04T15:58:31.255Z,1646409511.255 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2022-03-04T15:58:31.255Z,1646409511.255 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-03-04T15:58:31.256Z,1646409511.256 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-03-04T15:58:31.256Z,1646409511.256 [SBIT](INFO): Initialize SBIT Component.
2022-03-04T15:58:31.257Z,1646409511.257 [SBIT](IMPORTANT): git: 2021-12-16A-46-g3c12cfe83
2022-03-04T15:58:31.257Z,1646409511.257 [SBIT](INFO): git hash: 3c12cfe8371fa4ca97f1a7e624be52b6ed712841
2022-03-04T15:58:31.258Z,1646409511.258 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-03-04T15:58:31.259Z,1646409511.259 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2022-03-04T15:58:31.260Z,1646409511.260 [SBIT](INFO): Beginning SBIT in 30.000000 seconds.
2022-03-04T15:58:31.260Z,1646409511.260 [IBIT](INFO): Initialize IBIT Component.
2022-03-04T15:58:31.261Z,1646409511.261 [CBIT](DEBUG): Initialize CBIT Component.
2022-03-04T15:58:31.262Z,1646409511.262 [logger ThreadHandler](INFO): Handler Thread ID is 4377
2022-03-04T15:58:31.276Z,1646409511.276 [CBIT](DEBUG): Initialized mux pins.
2022-03-04T15:58:31.276Z,1646409511.276 [CBIT](DEBUG): Initializing the watchdog timer.
2022-03-04T15:58:31.288Z,1646409511.288 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4378
2022-03-04T15:58:31.289Z,1646409511.289 [DataOverHttps](DEBUG): dashIP=128.128.181.226 starts with a digit so assuming it is a numeric IP
2022-03-04T15:58:31.300Z,1646409511.300 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-03-04T15:58:31.300Z,1646409511.300 [CBIT](DEBUG): Initializing heartbeat.
2022-03-04T15:58:31.301Z,1646409511.301 [Onboard ThreadHandler](INFO): Handler Thread ID is 4379
2022-03-04T15:58:31.326Z,1646409511.326 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4380
2022-03-04T15:58:31.336Z,1646409511.336 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 4381
2022-03-04T15:58:31.337Z,1646409511.337 [WetLabsSeaOWL_UV_A](INFO): Powering down
2022-03-04T15:58:31.345Z,1646409511.345 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4382
2022-03-04T15:58:31.348Z,1646409511.348 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-03-04T15:58:31.348Z,1646409511.348 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-03-04T15:58:31.348Z,1646409511.348 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-03-04T15:58:31.348Z,1646409511.348 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-03-04T15:58:31.349Z,1646409511.349 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-03-04T15:58:31.349Z,1646409511.349 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-03-04T15:58:31.349Z,1646409511.349 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2022-03-04T15:58:31.349Z,1646409511.349 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2022-03-04T15:58:31.349Z,1646409511.349 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-03-04T15:58:31.350Z,1646409511.350 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-03-04T15:58:31.350Z,1646409511.350 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2022-03-04T15:58:31.350Z,1646409511.350 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2022-03-04T15:58:31.350Z,1646409511.350 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2022-03-04T15:58:31.350Z,1646409511.350 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2022-03-04T15:58:31.350Z,1646409511.350 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2022-03-04T15:58:31.351Z,1646409511.351 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2022-03-04T15:58:31.372Z,1646409511.372 [CBIT](DEBUG): Deactivating GF circuits.
2022-03-04T15:58:31.372Z,1646409511.372 [CBIT](DEBUG): Deactivating emergency mode.
2022-03-04T15:58:31.408Z,1646409511.408 [CBIT](DEBUG): Backplane powered.
2022-03-04T15:58:31.413Z,1646409511.413 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-03-04T15:58:31.438Z,1646409511.438 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-03-04T15:58:31.474Z,1646409511.474 [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>
2022-03-04T15:58:31.475Z,1646409511.475 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-03-04T15:58:31.562Z,1646409511.562 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-03-04T15:58:31.563Z,1646409511.563 [Default:A.Wait](DEBUG): Construct Wait.
2022-03-04T15:58:31.566Z,1646409511.566 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-03-04T15:58:31.606Z,1646409511.606 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-03-04T15:58:31.609Z,1646409511.609 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-03-04T15:58:31.642Z,1646409511.642 [Default:E.Execute](DEBUG): Construct Execute.
2022-03-04T15:58:31.658Z,1646409511.658 [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>
2022-03-04T15:58:31.662Z,1646409511.662 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,WorkSite,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2022-03-04T15:58:31.686Z,1646409511.686 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-03-04T15:58:31.728Z,1646409511.728 [Radio_Surface](INFO): Powering up
2022-03-04T15:58:31.742Z,1646409511.742 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:31.774Z,1646409511.774 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-03-04T15:58:31.780Z,1646409511.780 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-03-04T15:58:31.781Z,1646409511.781 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-03-04T15:58:31.782Z,1646409511.782 [MassServo](DEBUG): Initializing MassServo.
2022-03-04T15:58:31.783Z,1646409511.783 [RudderServo](DEBUG): Initializing RudderServo.
2022-03-04T15:58:31.797Z,1646409511.797 [CommandExec](FAULT): Scheduling is paused
2022-03-04T15:58:31.797Z,1646409511.797 [CBIT](INFO): Critical error at 20220304T155830
2022-03-04T15:58:31.797Z,1646409511.797 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-03-04T15:58:32.115Z,1646409512.115 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:32.480Z,1646409512.480 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:32.884Z,1646409512.884 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:33.288Z,1646409513.288 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:33.696Z,1646409513.696 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:34.096Z,1646409514.096 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:34.500Z,1646409514.500 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:34.956Z,1646409514.956 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:35.311Z,1646409515.311 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005011
2022-03-04T15:58:35.336Z,1646409515.336 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:35.740Z,1646409515.740 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:36.180Z,1646409516.180 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:36.310Z,1646409516.310 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-03-04T15:58:36.548Z,1646409516.548 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:36.952Z,1646409516.952 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:37.312Z,1646409517.312 [DataOverHttps](INFO): Radio surface powered ON.
2022-03-04T15:58:37.356Z,1646409517.356 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:37.760Z,1646409517.760 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:38.164Z,1646409518.164 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:38.568Z,1646409518.568 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:38.972Z,1646409518.972 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:39.376Z,1646409519.376 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:39.780Z,1646409519.780 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:40.180Z,1646409520.180 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:40.565Z,1646409520.565 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:40.968Z,1646409520.968 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:41.372Z,1646409521.372 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:41.776Z,1646409521.776 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:42.180Z,1646409522.180 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:42.584Z,1646409522.584 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:42.988Z,1646409522.988 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:43.392Z,1646409523.392 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:43.796Z,1646409523.796 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:44.200Z,1646409524.200 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:44.604Z,1646409524.604 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:45.008Z,1646409525.008 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:45.412Z,1646409525.412 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:45.816Z,1646409525.816 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:46.220Z,1646409526.220 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:46.624Z,1646409526.624 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:47.028Z,1646409527.028 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:47.432Z,1646409527.432 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:47.836Z,1646409527.836 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:48.240Z,1646409528.240 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:48.644Z,1646409528.644 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:49.048Z,1646409529.048 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:49.453Z,1646409529.453 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:49.856Z,1646409529.856 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:50.260Z,1646409530.260 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:50.680Z,1646409530.680 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:51.075Z,1646409531.075 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:51.472Z,1646409531.472 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:51.876Z,1646409531.876 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:52.280Z,1646409532.280 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:52.688Z,1646409532.688 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:53.088Z,1646409533.088 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:53.492Z,1646409533.492 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:53.896Z,1646409533.896 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:54.316Z,1646409534.316 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:54.704Z,1646409534.704 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:55.108Z,1646409535.108 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:55.512Z,1646409535.512 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:55.928Z,1646409535.928 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:56.320Z,1646409536.320 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:56.736Z,1646409536.736 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:57.128Z,1646409537.128 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:57.552Z,1646409537.552 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:57.936Z,1646409537.936 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:58.348Z,1646409538.348 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:58.756Z,1646409538.756 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:59.149Z,1646409539.149 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:59.559Z,1646409539.559 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:58:59.975Z,1646409539.975 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:00.360Z,1646409540.360 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:00.764Z,1646409540.764 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:01.176Z,1646409541.176 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:01.588Z,1646409541.588 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:01.980Z,1646409541.980 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:01.991Z,1646409541.991 [SBIT](IMPORTANT): Beginning Startup BIT
2022-03-04T15:59:01.995Z,1646409541.995 [CBIT](IMPORTANT): Beginning ground fault scan
2022-03-04T15:59:02.380Z,1646409542.380 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:02.792Z,1646409542.792 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:03.188Z,1646409543.188 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:03.592Z,1646409543.592 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:04.000Z,1646409544.000 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:04.408Z,1646409544.408 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:04.804Z,1646409544.804 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:04.843Z,1646409544.843 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes.
2022-03-04T15:59:05.208Z,1646409545.208 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:05.616Z,1646409545.616 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:06.036Z,1646409546.036 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:06.414Z,1646409546.414 [NAL9602](INFO): No messages in MT queue
2022-03-04T15:59:06.420Z,1646409546.420 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:06.824Z,1646409546.824 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:07.228Z,1646409547.228 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:07.652Z,1646409547.652 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:08.036Z,1646409548.036 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:08.484Z,1646409548.484 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:08.844Z,1646409548.844 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:09.260Z,1646409549.260 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:09.652Z,1646409549.652 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:10.068Z,1646409550.068 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:10.468Z,1646409550.468 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:10.868Z,1646409550.868 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:11.292Z,1646409551.292 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:11.676Z,1646409551.676 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:12.080Z,1646409552.080 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:12.484Z,1646409552.484 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:12.896Z,1646409552.896 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:12.926Z,1646409552.926 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.013109
CHAN A1 (24V) N/A reporting off
CHAN A2 (12V): -0.010281
CHAN A3 (5V): -0.003061
CHAN B0 (3.3V): -0.000452
CHAN B1 (3.15aV): -0.000879
CHAN B2 (3.15bV): -0.001244
CHAN B3 (GND): 0.002519
OPEN: -0.001001
Full Scale: +/- 1 mA
2022-03-04T15:59:13.292Z,1646409553.292 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:13.712Z,1646409553.712 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:14.116Z,1646409554.116 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:14.504Z,1646409554.504 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:14.908Z,1646409554.908 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:15.313Z,1646409555.313 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:15.337Z,1646409555.337 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-03-04T15:59:15.337Z,1646409555.337 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-03-04T15:59:15.337Z,1646409555.337 [SBIT](ERROR): Could not read massPosReader_.
2022-03-04T15:59:15.736Z,1646409555.736 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:16.120Z,1646409556.120 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:16.524Z,1646409556.524 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:16.928Z,1646409556.928 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:17.352Z,1646409557.352 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:17.736Z,1646409557.736 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:18.140Z,1646409558.140 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:18.544Z,1646409558.544 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:18.956Z,1646409558.956 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:19.352Z,1646409559.352 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:19.756Z,1646409559.756 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:20.168Z,1646409560.168 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:20.573Z,1646409560.573 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:20.965Z,1646409560.965 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:21.377Z,1646409561.377 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:21.777Z,1646409561.777 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:22.186Z,1646409562.186 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:22.591Z,1646409562.591 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:22.989Z,1646409562.989 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:23.393Z,1646409563.393 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:23.798Z,1646409563.798 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:24.207Z,1646409564.207 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:24.601Z,1646409564.601 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:25.009Z,1646409565.009 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:25.416Z,1646409565.416 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:25.821Z,1646409565.821 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:26.217Z,1646409566.217 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:26.637Z,1646409566.637 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:27.025Z,1646409567.025 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:27.437Z,1646409567.437 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:27.847Z,1646409567.847 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:28.241Z,1646409568.241 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:28.645Z,1646409568.645 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:29.052Z,1646409569.052 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:29.449Z,1646409569.449 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:29.864Z,1646409569.864 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:30.262Z,1646409570.262 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:30.668Z,1646409570.668 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:31.079Z,1646409571.079 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:31.476Z,1646409571.476 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:31.873Z,1646409571.873 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:32.285Z,1646409572.285 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:32.681Z,1646409572.681 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:33.093Z,1646409573.093 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:33.501Z,1646409573.501 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:33.900Z,1646409573.900 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:34.300Z,1646409574.300 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:34.712Z,1646409574.712 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:35.108Z,1646409575.108 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:35.524Z,1646409575.524 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:35.916Z,1646409575.916 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:36.320Z,1646409576.320 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:36.723Z,1646409576.723 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:37.135Z,1646409577.135 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:37.532Z,1646409577.532 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:37.934Z,1646409577.934 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:38.344Z,1646409578.344 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:38.751Z,1646409578.751 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:39.149Z,1646409579.149 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:39.554Z,1646409579.554 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:39.953Z,1646409579.953 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:40.380Z,1646409580.380 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:40.764Z,1646409580.764 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:40.873Z,1646409580.873 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 0.200000 meter
2022-03-04T15:59:40.893Z,1646409580.893 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread.
2022-03-04T15:59:41.168Z,1646409581.168 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-03-04T15:59:41.187Z,1646409581.187 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,WorkSite,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2022-03-04T15:59:41.995Z,1646409581.995 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-03-04T15:59:41.995Z,1646409581.995 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-03-04T15:59:41.995Z,1646409581.995 [SBIT](ERROR): Could not read massPosReader_.
2022-03-04T15:59:41.995Z,1646409581.995 [SBIT](FAULT): Control surface position failure.
2022-03-04T15:59:55.787Z,1646409595.787 [SBIT](ERROR): Could not read elevatorAngleReader_.
2022-03-04T15:59:55.787Z,1646409595.787 [SBIT](ERROR): Could not read rudderAngleReader_.
2022-03-04T15:59:55.787Z,1646409595.787 [SBIT](ERROR): Could not read massPosReader_.
2022-03-04T15:59:55.787Z,1646409595.787 [SBIT](FAULT): Control surface position failure.
2022-03-04T15:59:56.182Z,1646409596.182 [SBIT](CRITICAL): SBIT FAILED
2022-03-04T15:59:56.182Z,1646409596.182 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-03-04T15:59:56.183Z,1646409596.183 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=1 bool;
2022-03-04T15:59:56.183Z,1646409596.183 [SBIT](IMPORTANT): AHRS_M2.simulateHardware= 0 bool;
2022-03-04T15:59:56.183Z,1646409596.183 [SBIT](IMPORTANT): BuoyancyServo.loadAtStartup=1 bool;
2022-03-04T15:59:56.192Z,1646409596.192 [SBIT](IMPORTANT): BuoyancyServo.offsetVolume=32 cubic_centimeter;
2022-03-04T15:59:56.192Z,1646409596.192 [SBIT](IMPORTANT): DDM.loadAtStartup=0 bool;
2022-03-04T15:59:56.192Z,1646409596.192 [SBIT](IMPORTANT): ElevatorServo.loadAtStartup=1 bool;
2022-03-04T15:59:56.192Z,1646409596.192 [SBIT](IMPORTANT): ElevatorServo.simulateHardware=1 bool;
2022-03-04T15:59:56.192Z,1646409596.192 [SBIT](IMPORTANT): MassServo.simulateHardware=1 bool;
2022-03-04T15:59:56.192Z,1646409596.192 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool;
2022-03-04T15:59:56.193Z,1646409596.193 [SBIT](IMPORTANT): RudderServo.loadAtStartup=1 bool;
2022-03-04T15:59:56.193Z,1646409596.193 [SBIT](IMPORTANT): RudderServo.simulateHardware=1 bool;
2022-03-04T15:59:56.193Z,1646409596.193 [SBIT](IMPORTANT): ThrusterHE.loadAtStartup=0 bool;
2022-03-04T15:59:56.193Z,1646409596.193 [SBIT](IMPORTANT): ThrusterServo.loadAtStartup=0 bool;
2022-03-04T15:59:56.193Z,1646409596.193 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=288.614464 cubic_centimeter;
2022-03-04T15:59:56.193Z,1646409596.193 [SBIT](IMPORTANT): VerticalControl.massDefault=2.506765 millimeter;
2022-03-04T15:59:56.193Z,1646409596.193 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-29 millimeter;
2022-03-04T15:59:56.194Z,1646409596.194 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=30 millimeter;
2022-03-04T15:59:56.195Z,1646409596.195 [CBIT](INFO): Critical error at 20220304T155956
2022-03-04T15:59:56.569Z,1646409596.569 [WorkSite](IMPORTANT): Reading workSite position from Data/workSite.cfg
2022-03-04T15:59:56.570Z,1646409596.570 [MissionManager](IMPORTANT): Started mission Startup
2022-03-04T15:59:56.571Z,1646409596.571 [Startup] Running Loop=1
2022-03-04T15:59:56.571Z,1646409596.571 [Startup](DEBUG): Aggregate::initialize Startup
2022-03-04T15:59:56.571Z,1646409596.571 [Startup:A.GoToSurface] Running Loop=1
2022-03-04T15:59:56.571Z,1646409596.571 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-03-04T15:59:56.572Z,1646409596.572 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-03-04T15:59:56.573Z,1646409596.573 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-03-04T15:59:56.573Z,1646409596.573 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-03-04T15:59:56.573Z,1646409596.573 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-03-04T15:59:56.574Z,1646409596.574 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-03-04T15:59:56.576Z,1646409596.576 [Startup:StartupSatComms] Running Loop=1
2022-03-04T15:59:56.576Z,1646409596.576 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-03-04T15:59:56.576Z,1646409596.576 [Startup:StartupSatComms:A] Running Loop=1
2022-03-04T15:59:56.953Z,1646409596.953 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-03-04T16:00:17.257Z,1646409617.257 [CommandExec](IMPORTANT): got command get platform_buoyancy_position
2022-03-04T16:00:17.258Z,1646409617.258 [CommandExec](IMPORTANT): platform_buoyancy_position 947.718567 cc
2022-03-04T16:00:56.753Z,1646409656.753 [Startup:StartupSatComms:A](INFO): Timed out from 2022-03-04T15:59:56.6Z
2022-03-04T16:00:56.753Z,1646409656.753 [Startup:StartupSatComms:A] Stopped
2022-03-04T16:00:56.753Z,1646409656.753 [Startup:StartupSatComms:B] Running Loop=1
2022-03-04T16:00:57.147Z,1646409657.147 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-03-04T16:01:02.056Z,1646409662.056 [DataOverHttps](INFO): Sending 110 bytes from file Logs/20220303T215752/Courier0007.lzma
2022-03-04T16:01:03.058Z,1646409663.058 [DataOverHttps](INFO): Moved sent file to Logs/20220303T215752/Courier0007.lzma.bak
2022-03-04T16:01:03.058Z,1646409663.058 [DataOverHttps](INFO): SBD MOMSN=1758745
2022-03-04T16:01:13.212Z,1646409673.212 [DataOverHttps](INFO): Sending 356 bytes from file Logs/20220304T155822/Courier0000.lzma
2022-03-04T16:01:14.214Z,1646409674.214 [DataOverHttps](INFO): Moved sent file to Logs/20220304T155822/Courier0000.lzma.bak
2022-03-04T16:01:14.214Z,1646409674.214 [DataOverHttps](INFO): SBD MOMSN=1758748
2022-03-04T16:01:25.600Z,1646409685.600 [DataOverHttps](INFO): Sending 442 bytes from file Logs/20220303T215752/Express0008.lzma
2022-03-04T16:01:26.601Z,1646409686.601 [DataOverHttps](INFO): Moved sent file to Logs/20220303T215752/Express0008.lzma.bak
2022-03-04T16:01:26.602Z,1646409686.602 [DataOverHttps](INFO): SBD MOMSN=1758758
2022-03-04T16:01:31.490Z,1646409691.490 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-03-04T16:01:31.491Z,1646409691.491 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:01:31.502Z,1646409691.502 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:01:31.907Z,1646409691.907 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:01:31.908Z,1646409691.908 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2022-03-04T16:01:37.973Z,1646409697.973 [DataOverHttps](INFO): Sending 882 bytes from file Logs/20220304T155822/Express0001.lzma
2022-03-04T16:01:38.973Z,1646409698.973 [DataOverHttps](INFO): Moved sent file to Logs/20220304T155822/Express0001.lzma.bak
2022-03-04T16:01:38.974Z,1646409698.974 [DataOverHttps](INFO): SBD MOMSN=1758785
2022-03-04T16:01:42.397Z,1646409702.397 [Startup:StartupSatComms:B] Stopped
2022-03-04T16:01:42.397Z,1646409702.397 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-03-04T16:01:42.397Z,1646409702.397 [Startup:StartupSatComms] Stopped
2022-03-04T16:01:42.397Z,1646409702.397 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-03-04T16:01:42.398Z,1646409702.398 [Startup](INFO): Completed Startup
2022-03-04T16:01:42.399Z,1646409702.399 [MissionManager](INFO): Startup is completed.
2022-03-04T16:01:42.399Z,1646409702.399 [MissionManager](INFO): Uninitializing Mission Startup
2022-03-04T16:01:42.399Z,1646409702.399 [Startup] Stopped
2022-03-04T16:01:42.399Z,1646409702.399 [Startup](DEBUG): Aggregate::uninitialize Startup
2022-03-04T16:01:42.399Z,1646409702.399 [Startup:A.GoToSurface] Stopped
2022-03-04T16:01:42.399Z,1646409702.399 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-03-04T16:01:42.817Z,1646409702.817 [MissionManager](IMPORTANT): Started mission Default
2022-03-04T16:01:42.817Z,1646409702.817 [Default] Running Loop=1
2022-03-04T16:01:42.817Z,1646409702.817 [Default](DEBUG): Aggregate::initialize Default
2022-03-04T16:01:42.817Z,1646409702.817 [Default:B.GoToSurface] Running Loop=1
2022-03-04T16:01:42.817Z,1646409702.817 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-03-04T16:01:42.818Z,1646409702.818 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-03-04T16:01:42.818Z,1646409702.818 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-03-04T16:01:42.818Z,1646409702.818 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-03-04T16:01:42.819Z,1646409702.819 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-03-04T16:01:42.819Z,1646409702.819 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-03-04T16:01:42.819Z,1646409702.819 [Default:A.Wait] Running Loop=1
2022-03-04T16:01:42.819Z,1646409702.819 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-03-04T16:01:44.409Z,1646409704.409 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2022-03-04T16:01:44.409Z,1646409704.409 [RDI_Pathfinder] Data Fault, FailCount= 1
2022-03-04T16:01:44.409Z,1646409704.409 [RDI_Pathfinder](ERROR): Data Fault
2022-03-04T16:01:44.447Z,1646409704.447 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2022-03-04T16:01:44.811Z,1646409704.811 [RDI_Pathfinder](INFO): Powering down
2022-03-04T16:01:45.640Z,1646409705.640 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2022-03-04T16:01:45.640Z,1646409705.640 [RDI_Pathfinder] No Fault, FailCount= 1
2022-03-04T16:01:56.130Z,1646409716.130 [Default:A.Wait](INFO): Done Waiting.
2022-03-04T16:01:56.130Z,1646409716.130 [Default:A.Wait] Stopped
2022-03-04T16:01:56.130Z,1646409716.130 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-03-04T16:01:56.547Z,1646409716.547 [Default:CheckIn] Running Loop=1
2022-03-04T16:01:56.547Z,1646409716.547 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-03-04T16:01:56.549Z,1646409716.549 [Default:CheckIn:Read_GPS] Running Loop=1
2022-03-04T16:01:56.952Z,1646409716.952 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-03-04T16:04:32.481Z,1646409872.481 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2022-03-04T16:04:32.481Z,1646409872.481 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:04:32.492Z,1646409872.492 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:04:32.904Z,1646409872.904 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:04:32.904Z,1646409872.904 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2022-03-04T16:04:48.545Z,1646409888.545 [DataOverHttps](IMPORTANT): SBD MTMSN=20220304T160447
2022-03-04T16:04:52.564Z,1646409892.564 [DataOverHttps](INFO): Received command: load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 10 min;set sci2_flat_and_level.Depth 0.2 m;run
2022-03-04T16:04:52.641Z,1646409892.641 [CommandExec](IMPORTANT): got command load ./Missions/Science/sci2_flat_and_level.xml
2022-03-04T16:04:52.642Z,1646409892.642 [MissionManager](INFO): Loading Mission from file: ./Missions/Science/sci2_flat_and_level.xml
2022-03-04T16:04:52.886Z,1646409892.886 [MissionManager](INFO): DefineArg sci2_flat_and_level.MissionTimeout = 2.000000 h
2022-03-04T16:04:52.889Z,1646409892.889 [MissionManager](INFO): DefineArg sci2_flat_and_level.NeedCommsTime = 60.000000 min
2022-03-04T16:04:52.892Z,1646409892.892 [MissionManager](INFO): DefineArg sci2_flat_and_level.Depth = 3.000000 m
2022-03-04T16:04:52.895Z,1646409892.895 [MissionManager](INFO): DefineArg sci2_flat_and_level.Repeat = 1.000000 count
2022-03-04T16:04:52.898Z,1646409892.898 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat1 = nan arcdeg
2022-03-04T16:04:52.901Z,1646409892.901 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon1 = nan arcdeg
2022-03-04T16:04:52.904Z,1646409892.904 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat2 = nan arcdeg
2022-03-04T16:04:52.907Z,1646409892.907 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon2 = nan arcdeg
2022-03-04T16:04:52.962Z,1646409892.962 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat3 = nan arcdeg
2022-03-04T16:04:52.978Z,1646409892.978 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon3 = nan arcdeg
2022-03-04T16:04:52.981Z,1646409892.981 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat4 = nan arcdeg
2022-03-04T16:04:52.984Z,1646409892.984 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon4 = nan arcdeg
2022-03-04T16:04:52.987Z,1646409892.987 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat5 = nan arcdeg
2022-03-04T16:04:53.019Z,1646409893.019 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon5 = nan arcdeg
2022-03-04T16:04:53.022Z,1646409893.022 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat6 = nan arcdeg
2022-03-04T16:04:53.025Z,1646409893.025 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon6 = nan arcdeg
2022-03-04T16:04:53.028Z,1646409893.028 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat7 = nan arcdeg
2022-03-04T16:04:53.031Z,1646409893.031 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon7 = nan arcdeg
2022-03-04T16:04:53.034Z,1646409893.034 [MissionManager](INFO): DefineArg sci2_flat_and_level.Speed = 1.000000 m/s
2022-03-04T16:04:53.090Z,1646409893.090 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepth = 2.000000 m
2022-03-04T16:04:53.115Z,1646409893.115 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSpeed = 0.700000 m/s
2022-03-04T16:04:53.118Z,1646409893.118 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepthRate = 0.050000 m/s
2022-03-04T16:04:53.122Z,1646409893.122 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachPitchLimit = 20.000000 arcdeg
2022-03-04T16:04:53.153Z,1646409893.153 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepthTimeout = 15.000000 min
2022-03-04T16:04:53.156Z,1646409893.156 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSettleTimePreDive = 1.000000 min
2022-03-04T16:04:53.159Z,1646409893.159 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSettleTimePostDive = 3.000000 min
2022-03-04T16:04:53.163Z,1646409893.163 [MissionManager](INFO): DefineArg sci2_flat_and_level.kpDepth = 0.070000 rad/m
2022-03-04T16:04:53.171Z,1646409893.171 [MissionManager](INFO): DefineArg sci2_flat_and_level.BuoyancyNeutral = 288.614479 cc
2022-03-04T16:04:53.183Z,1646409893.183 [MissionManager](INFO): DefineArg sci2_flat_and_level.MassDefault = 0.250676 cm
2022-03-04T16:04:53.186Z,1646409893.186 [MissionManager](INFO): DefineArg sci2_flat_and_level.MinAltitude = 2.000000 m
2022-03-04T16:04:53.208Z,1646409893.208 [MissionManager](INFO): DefineArg sci2_flat_and_level.MaxDepth = 15.000000 m
2022-03-04T16:04:53.211Z,1646409893.211 [MissionManager](INFO): DefineArg sci2_flat_and_level.MinOffshore = 2.000000 km
2022-03-04T16:04:53.227Z,1646409893.227 [MissionManager](INFO): DefineOutput sci2_flat_and_level.DiveMode = 0.000000 count
2022-03-04T16:04:53.234Z,1646409893.234 [MissionManager](INFO): DefineOutput sci2_flat_and_level.DoingComms = 0.000000 count
2022-03-04T16:04:53.238Z,1646409893.238 [MissionManager](INFO): DefineOutput sci2_flat_and_level.InitialDive = 1.000000 count
2022-03-04T16:04:53.258Z,1646409893.258 [MissionManager](INFO): DefineOutput sci2_flat_and_level.SettleAtDepth = 2.000000 count
2022-03-04T16:04:53.265Z,1646409893.265 [MissionManager](INFO): DefineOutput sci2_flat_and_level.MaintainDepth = 3.000000 count
2022-03-04T16:04:53.266Z,1646409893.266 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml
2022-03-04T16:04:53.773Z,1646409893.773 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.SampleISUS = 0 bool
2022-03-04T16:04:53.788Z,1646409893.788 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.SampleISUSmaxPitch = 60.000000 arcdeg
2022-03-04T16:04:53.791Z,1646409893.791 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.SampleISUSminPitch = -60.000000 arcdeg
2022-03-04T16:04:53.793Z,1646409893.793 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectChlActive = 0 bool
2022-03-04T16:04:53.826Z,1646409893.826 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.TimeWindowPeakReport = nan min
2022-03-04T16:04:53.829Z,1646409893.829 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.HighestChlPeakReportActive = 0 bool
2022-03-04T16:04:53.831Z,1646409893.831 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PatchTracking = 0 bool
2022-03-04T16:04:53.834Z,1646409893.834 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.FilterWidthHorizontal = 3.000000 count
2022-03-04T16:04:53.842Z,1646409893.842 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.NumProfilesSlidingwindow = 100.000000 count
2022-03-04T16:04:53.845Z,1646409893.845 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.OffPeakFractionHorizontal = 80.000000 %
2022-03-04T16:04:53.848Z,1646409893.848 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectNO3Active = 0 bool
2022-03-04T16:04:53.850Z,1646409893.850 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectOilActive = 0 bool
2022-03-04T16:04:53.906Z,1646409893.906 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectFDOMActive = 0 bool
2022-03-04T16:04:53.909Z,1646409893.909 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2022-03-04T16:04:53.912Z,1646409893.912 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledAanderaaO2 = 0.000000 bool
2022-03-04T16:04:53.942Z,1646409893.942 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledNeilBrown = 0.000000 bool
2022-03-04T16:04:53.946Z,1646409893.946 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledSeabird = 0.000000 bool
2022-03-04T16:04:53.949Z,1646409893.949 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledTurbulence_NPS = 0.000000 bool
2022-03-04T16:04:53.970Z,1646409893.970 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsBB2FL = 0.000000 bool
2022-03-04T16:04:53.983Z,1646409893.983 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsSeaOWL_UV_A = 1.000000 bool
2022-03-04T16:04:53.986Z,1646409893.986 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsUBAT = 0.000000 bool
2022-03-04T16:04:53.990Z,1646409893.990 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledISUS = 0.000000 bool
2022-03-04T16:04:54.025Z,1646409894.025 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.LowPassWindowLength = 20.000000 count
2022-03-04T16:04:54.028Z,1646409894.028 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.MedianFilterLen = 5.000000 count
2022-03-04T16:04:54.031Z,1646409894.031 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakChlShallowBound = nan m
2022-03-04T16:04:54.034Z,1646409894.034 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakChlDeepBound = nan m
2022-03-04T16:04:54.048Z,1646409894.048 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakShallowBound = nan m
2022-03-04T16:04:54.061Z,1646409894.061 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDeepBound = nan m
2022-03-04T16:04:54.065Z,1646409894.065 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChl = 0.000000 ug/l
2022-03-04T16:04:54.068Z,1646409894.068 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlDepth = 0.000000 m
2022-03-04T16:04:54.071Z,1646409894.071 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlTemperature = 0.000000 degC
2022-03-04T16:04:54.074Z,1646409894.074 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlLatitude = nan arcdeg
2022-03-04T16:04:54.077Z,1646409894.077 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlLongitude = nan arcdeg
2022-03-04T16:04:54.080Z,1646409894.080 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3 = 0.000000 umol/l
2022-03-04T16:04:54.083Z,1646409894.083 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Depth = 0.000000 m
2022-03-04T16:04:54.110Z,1646409894.110 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Latitude = nan arcdeg
2022-03-04T16:04:54.113Z,1646409894.113 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Longitude = nan arcdeg
2022-03-04T16:04:54.134Z,1646409894.134 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChl = 0.000000 m
2022-03-04T16:04:54.137Z,1646409894.137 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlDepth = 0.000000 m
2022-03-04T16:04:54.141Z,1646409894.141 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlLatitude = nan arcdeg
2022-03-04T16:04:54.161Z,1646409894.161 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlLongitude = nan arcdeg
2022-03-04T16:04:54.182Z,1646409894.182 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlDistance = nan m
2022-03-04T16:04:54.186Z,1646409894.186 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOil = 0.000000 kg/m3
2022-03-04T16:04:54.189Z,1646409894.189 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilDepth = 0.000000 m
2022-03-04T16:04:54.221Z,1646409894.221 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilLatitude = nan arcdeg
2022-03-04T16:04:54.224Z,1646409894.224 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilLongitude = nan arcdeg
2022-03-04T16:04:54.227Z,1646409894.227 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOM = 0.000000 ppb
2022-03-04T16:04:54.230Z,1646409894.230 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMDepth = 0.000000 m
2022-03-04T16:04:54.243Z,1646409894.243 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMLatitude = nan arcdeg
2022-03-04T16:04:54.246Z,1646409894.246 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMLongitude = nan arcdeg
2022-03-04T16:04:54.249Z,1646409894.249 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchFDOMDistance = nan m
2022-03-04T16:04:54.363Z,1646409894.363 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-03-04T16:04:54.423Z,1646409894.423 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2022-03-04T16:04:54.452Z,1646409894.452 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-03-04T16:04:54.487Z,1646409894.487 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-03-04T16:04:54.514Z,1646409894.514 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-03-04T16:04:54.532Z,1646409894.532 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2022-03-04T16:04:54.586Z,1646409894.586 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MinAltitude = 5.000000 m
2022-03-04T16:04:54.601Z,1646409894.601 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MaxDepth = 200.000000 m
2022-03-04T16:04:54.616Z,1646409894.616 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MinOffshore = 2000.000000 m
2022-03-04T16:04:54.617Z,1646409894.617 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2022-03-04T16:04:54.632Z,1646409894.632 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2022-03-04T16:04:54.649Z,1646409894.649 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2022-03-04T16:04:54.740Z,1646409894.740 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2022-03-04T16:04:54.841Z,1646409894.841 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.DiveInterval = 3.000000 h
2022-03-04T16:04:54.852Z,1646409894.852 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.WaitForPitchUp = 10.000000 min
2022-03-04T16:04:54.855Z,1646409894.855 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfacePitch = 20.000000 arcdeg
2022-03-04T16:04:54.871Z,1646409894.871 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfaceDepthRate = nan m/s
2022-03-04T16:04:54.874Z,1646409894.874 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfaceSpeed = 1.000000 m/s
2022-03-04T16:04:54.885Z,1646409894.885 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.GPSTimeout = 7.000000 min
2022-03-04T16:04:54.896Z,1646409894.896 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.CommsTimeout = 30.000000 min
2022-03-04T16:04:54.903Z,1646409894.903 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-03-04T16:04:54.999Z,1646409894.999 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass](DEBUG): Construct.
2022-03-04T16:04:55.037Z,1646409895.037 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy](DEBUG): Construct Buoyancy.
2022-03-04T16:04:55.041Z,1646409895.041 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait](DEBUG): Construct Wait.
2022-03-04T16:04:55.059Z,1646409895.059 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed](DEBUG): Construct.
2022-03-04T16:04:55.062Z,1646409895.062 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch](DEBUG): Construct.
2022-03-04T16:04:55.083Z,1646409895.083 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute.
2022-03-04T16:04:55.146Z,1646409895.146 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch](DEBUG): Construct.
2022-03-04T16:04:55.151Z,1646409895.151 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait](DEBUG): Construct Wait.
2022-03-04T16:04:55.223Z,1646409895.223 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:ThrusterDive:A.Mass](DEBUG): Construct.
2022-03-04T16:04:55.226Z,1646409895.226 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:ThrusterDive:B.Buoyancy](DEBUG): Construct Buoyancy.
2022-03-04T16:04:55.229Z,1646409895.229 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.SetSpeed](DEBUG): Construct.
2022-03-04T16:04:55.251Z,1646409895.251 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.Pitch](DEBUG): Construct.
2022-03-04T16:04:55.297Z,1646409895.297 [sci2_flat_and_level:Lap:Wpt1:A.Waypoint](DEBUG): Construct Waypoint.
2022-03-04T16:04:55.322Z,1646409895.322 [sci2_flat_and_level:Lap:Wpt2:A.Waypoint](DEBUG): Construct Waypoint.
2022-03-04T16:04:55.329Z,1646409895.329 [sci2_flat_and_level:Lap:Wpt3:A.Waypoint](DEBUG): Construct Waypoint.
2022-03-04T16:04:55.346Z,1646409895.346 [sci2_flat_and_level:Lap:Wpt4:A.Waypoint](DEBUG): Construct Waypoint.
2022-03-04T16:04:55.378Z,1646409895.378 [sci2_flat_and_level:Lap:Wpt5:A.Waypoint](DEBUG): Construct Waypoint.
2022-03-04T16:04:55.407Z,1646409895.407 [sci2_flat_and_level:Lap:Wpt6:A.Waypoint](DEBUG): Construct Waypoint.
2022-03-04T16:04:55.433Z,1646409895.433 [sci2_flat_and_level:Lap:Wpt7:A.Waypoint](DEBUG): Construct Waypoint.
2022-03-04T16:04:55.583Z,1646409895.583 [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:Control="Tethys/Control"
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/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
Id="sci2_flat_and_level">
<Description>
Vehicle transits to the specified waypoints at the commanded depth (flat-and-level) with science turned on.
</Description>
<DefineArg Name="MissionTimeout"><Description>
Maximum duration of mission
</Description><Units:hour/><Value>2</Value></DefineArg>
<DefineArg Name="NeedCommsTime"><Description>
How often to surface for commumications
</Description><Units:minute/><Value>60</Value></DefineArg>
<DefineArg Name="Depth"><Description>
Depth of flat and level flight during the mission.
</Description><Units:meter /><Value>3</Value></DefineArg>
<DefineArg Name="Repeat"><Description>
Number of times the vehicle should try to cycle through waypoints.
</Description><Units:count/><Value>1</Value></DefineArg>
<DefineArg Name="Lat1"><Description>
Latitude of waypoint 1. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lon1"><Description>
Longitude of waypoint 1. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lat2"><Description>
Latitude of waypoint 2. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lon2"><Description>
Longitude of waypoint 2. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lat3"><Description>
Latitude of waypoint 3. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lon3"><Description>
Longitude of waypoint 3. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lat4"><Description>
Latitude of waypoint 4. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lon4"><Description>
Longitude of waypoint 4. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lat5"><Description>
Latitude of waypoint 5. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lon5"><Description>
Longitude of waypoint 5. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lat6"><Description>
Latitude of waypoint 6. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lon6"><Description>
Longitude of waypoint 6. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lat7"><Description>
Latitude of waypoint 7. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Lon7"><Description>
Longitude of waypoint 7. If nan, waypoint is skipped.
</Description><Units:degree/><Value>NaN</Value></DefineArg>
<DefineArg Name="Speed"><Description>
Speed while transiting to waypoints.
</Description><Units:meter_per_second/><Value>1</Value></DefineArg>
<DefineArg Name="ApproachDepth"><Description>
Depth for initial descent form the surface.
</Description><Units:meter/><Value>2</Value></DefineArg>
<DefineArg Name="ApproachSpeed"><Description>
Speed while descending to target depth.
</Description><Units:meter_per_second/><Value>0.7</Value></DefineArg>
<DefineArg Name="ApproachDepthRate"><Description>
Descent depth rate (Positive depth rate means going down).
</Description><Units:meter_per_second/><Value>0.05</Value></DefineArg>
<DefineArg Name="ApproachPitchLimit"><Description>
Max vehicle pitch (+/-) when decending from the surface.
</Description><Units:degree/><Value>20</Value></DefineArg>
<DefineArg Name="ApproachDepthTimeout"><Description>
Maximum time duration for the vehicle to reach the target depth
</Description><Units:minute/><Value>15</Value></DefineArg>
<DefineArg Name="ApproachSettleTimePreDive"><Description>
Time duration for the vehicle to pump down the VBS *BEFORE* leaving the surface.
</Description><Units:minute/><Value>1</Value></DefineArg>
<DefineArg Name="ApproachSettleTimePostDive"><Description>
Time duration for the vehicle to settle *AFTER* reaching the target depth.
</Description><Units:minute/><Value>3</Value></DefineArg>
<DefineArg Name="kpDepth"><Description>
Dive loop proportional gain (applied only while the vehicle is descending to target depth).
</Description><Units:radian_per_meter/><Value>0.07</Value></DefineArg>
<DefineArg Name="BuoyancyNeutral"><Description>
Buoyancy bladder position during the mission. Defaults to buoyancyNeutral
setting in the Config/Control.cfg file. Set to NaN cc for active buoyancy.
</Description><Control:VerticalControl.buoyancyNeutral/></DefineArg>
<DefineArg Name="MassDefault"><Description>
Static setting for mass during the mission. Set to NaN mm for active
mass position.
</Description><Control:VerticalControl.massDefault/></DefineArg>
<DefineArg Name="MinAltitude"><Description>
Minimum height above the sea floor for the entire mission.
</Description><Units:meter/><Value>2</Value></DefineArg>
<DefineArg Name="MaxDepth"><Description>
Maximum depth for the entire mission.
</Description><Units:meter/><Value>15</Value></DefineArg>
<DefineArg Name="MinOffshore"><Description>
Minimum offshore distance for the entire mission.
</Description><Units:kilometer/><Value>2</Value></DefineArg>
<DefineOutput Name="DiveMode"><Description>
Mission variable (don't change). The mission sets this variable to switch
between dive modes. Initialized to DoingComms.
</Description><Units:count/><Value>0</Value></DefineOutput>
<DefineOutput Name="DoingComms"><Description>
Mission variable (don't change).
The mission will run in this to mode when doing surface comms.
</Description><Units:count/><Value>0</Value></DefineOutput>
<DefineOutput Name="InitialDive"><Description>
Mission variable (don't change).
The mission will run in this mode after surface comms are done to dive the
vehicle to the approach depth.
</Description><Units:count/><Value>1</Value></DefineOutput>
<DefineOutput Name="SettleAtDepth"><Description>
Mission variable (don't change).
The mission will run in this mode to settle the vehicle at the target depth.
</Description><Units:count/><Value>2</Value></DefineOutput>
<DefineOutput Name="MaintainDepth"><Description>
Mission variable (don't change).
The mission will run in this mode to maintain the vehicle at the target depth.
</Description><Units:count/><Value>3</Value></DefineOutput>
<!-- Mission timeout -->
<Timeout Duration="MissionTimeout"/>
<!-- Science! -->
<Insert Filename="Insert/Science.xml">
<Description>
Run the science sensors.
</Description>
</Insert>
<!-- Safety nets and surfacing behaviors -->
<Insert Filename="Insert/StandardEnvelopes.xml"/>
<Assign><Sequence/><Arg Name="StandardEnvelopes:MinAltitude"/><Arg Name="MinAltitude"/></Assign>
<Assign><Sequence/><Arg Name="StandardEnvelopes:MaxDepth"/><Arg Name="MaxDepth"/></Assign>
<Assign><Sequence/><Arg Name="StandardEnvelopes:MinOffshore"/><Arg Name="MinOffshore"/></Assign>
<Insert Filename="Insert/NeedComms.xml" Id="NeedComms"/>
<Assign><Sequence/><Arg Name="NeedComms:DiveInterval"/><Arg Name="MissionTimeout"/></Assign>
<Assign><Sequence/><Arg Name="NeedComms:WaitForPitchUp"/><Units:minute/><Value>0</Value></Assign>
<Aggregate Id="SurfaceComms">
<When>
<Called/>
<Or><Elapsed><Universal:time_fix/></Elapsed><Gt><Arg Name="NeedCommsTime"/></Gt></Or>
</When>
<Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="DoingComms"/></Assign>
<Call RefId="NeedComms"/>
<Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="InitialDive"/></Assign>
</Aggregate>
<Aggregate Id="DiveCmd">
<Description>
Called when the vehicle should be underwater.
Arbitrates between 3 dive modes:
1) descend from the surface to initial depth.
2) settle at target depth using the VB.
3) cruise at target depth.
</Description>
<When>
<Called/>
</When>
<Aggregate Id="InitialDive">
<Description>
Descend from the surface to target depth, limit pitch and depth-rate.
</Description>
<While>
<Arg Name="DiveMode"/><Eq><Arg Name="InitialDive"/></Eq>
</While>
<Aggregate Id="dive">
<Sequence/>
<Assign><Parallel/><Control:VerticalControl.pitchLimit/><Arg Name="ApproachPitchLimit"/></Assign>
<Assign><Parallel/><Control:VerticalControl.kpDepth/><Arg Name="kpDepth"/></Assign>
<Guidance:Mass>
<Parallel/>
<Setting><Guidance:Mass.position/><Arg Name="MassDefault"/></Setting>
</Guidance:Mass>
<Guidance:Buoyancy>
<Parallel/>
<Setting><Guidance:Buoyancy.position/><Arg Name="BuoyancyNeutral"/></Setting>
</Guidance:Buoyancy>
<Syslog Severity="Info">Waiting for <Arg Name="ApproachSettleTimePreDive"/><Units:minute/>while pumping down to neutral.</Syslog>
<Guidance:Wait>
<Description>Take a few moments to ensure the VBS reaches neutral.</Description>
<Sequence/>
<Setting><Guidance:Wait.duration/><Arg Name="ApproachSettleTimePreDive"/></Setting>
</Guidance:Wait>
<Syslog>Moving to <Arg Name="ApproachDepth"/><Units:meter/></Syslog>
<Aggregate Id="ApproachDepth">
<Sequence/>
<Guidance:SetSpeed>
<Parallel/>
<Setting><Guidance:SetSpeed.speed/><Arg Name="ApproachSpeed"/></Setting>
</Guidance:SetSpeed>
<Guidance:Pitch>
<Sequence/>
<Timeout Duration="ApproachDepthTimeout">
<Syslog Severity="Important">Timed out while trying to reach target depth at current depth of <Universal:depth/><Units:meter/></Syslog>
<Guidance:Execute>
<Sequence/>
<Setting><Guidance:Execute.command/><String>stop</String></Setting>
</Guidance:Execute>
</Timeout>
<Setting><Guidance:Pitch.depth/><Arg Name="ApproachDepth"/></Setting>
<Setting><Guidance:Pitch.depthRate/><Arg Name="ApproachDepthRate"/></Setting>
</Guidance:Pitch>
</Aggregate>
<Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="SettleAtDepth"/></Assign>
</Aggregate>
</Aggregate>
<Aggregate Id="SettleAtDepth">
<Description>
Take a few more moments here to make sure the vechile is settled at the target depth.
</Description>
<While>
<Arg Name="DiveMode"/><Eq><Arg Name="SettleAtDepth"/></Eq>
</While>
<Aggregate Id="dive">
<Sequence/>
<Syslog Severity="Info">Reached <Universal:depth/><Units:meter/>, settling for <Arg Name="ApproachSettleTimePostDive"/><Units:minute/></Syslog>
<Guidance:Pitch>
<Parallel/>
<Setting><Guidance:Pitch.depth/><Arg Name="Depth"/></Setting>
</Guidance:Pitch>
<Guidance:Wait>
<Sequence/>
<Setting><Guidance:Wait.duration/><Arg Name="ApproachSettleTimePostDive"/></Setting>
</Guidance:Wait>
<Assign><Sequence/><Arg Name="DiveMode"/><Arg Name="MaintainDepth"/></Assign>
</Aggregate>
</Aggregate>
<Aggregate Id="MaintainDepth">
<Description>
Cruise at the target depth.
</Description>
<While>
<Arg Name="DiveMode"/><Eq><Arg Name="MaintainDepth"/></Eq>
</While>
<Aggregate Id="dive">
<Parallel/>
<Aggregate Id="ThrusterDive">
<While>
<Arg Name="Speed"/><Gt><Units:meter_per_second/><Value>0.0</Value></Gt>
</While>
<Guidance:Mass>
<Parallel/>
<Setting><Guidance:Mass.position/><Arg Name="MassDefault"/></Setting>
</Guidance:Mass>
<Guidance:Buoyancy>
<Parallel/>
<Setting><Guidance:Buoyancy.position/><Arg Name="BuoyancyNeutral"/></Setting>
</Guidance:Buoyancy>
</Aggregate>
<Guidance:SetSpeed>
<Parallel/>
<Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
</Guidance:SetSpeed>
<Guidance:Pitch>
<Parallel/>
<Setting><Guidance:Pitch.depth/><Arg Name="Depth"/></Setting>
</Guidance:Pitch>
</Aggregate>
</Aggregate>
</Aggregate>
<!-- Start mission sequence -->
<Call Id="StartingMission" RefId="SurfaceComms"/>
<Aggregate Id="Lap">
<Sequence Repeat="Repeat"/>
<Aggregate Id="Dive">
<While>
<Not><Arg Name="DiveMode"/><Eq><Arg Name="DoingComms"/></Eq></Not>
</While>
<Call RefId="DiveCmd"/>
</Aggregate>
<Aggregate Id="Wpt1">
<Sequence/>
<Guidance:Waypoint>
<Sequence/>
<Setting><Guidance:Waypoint.latitude/><Arg Name="Lat1"/></Setting>
<Setting><Guidance:Waypoint.longitude/><Arg Name="Lon1"/></Setting>
</Guidance:Waypoint>
</Aggregate>
<Aggregate Id="Wpt2">
<Sequence/>
<Guidance:Waypoint>
<Sequence/>
<Setting><Guidance:Waypoint.latitude/><Arg Name="Lat2"/></Setting>
<Setting><Guidance:Waypoint.longitude/><Arg Name="Lon2"/></Setting>
</Guidance:Waypoint>
</Aggregate>
<Aggregate Id="Wpt3">
<Sequence/>
<Guidance:Waypoint>
<Sequence/>
<Setting><Guidance:Waypoint.latitude/><Arg Name="Lat3"/></Setting>
<Setting><Guidance:Waypoint.longitude/><Arg Name="Lon3"/></Setting>
</Guidance:Waypoint>
</Aggregate>
<Aggregate Id="Wpt4">
<Sequence/>
<Guidance:Waypoint>
<Sequence/>
<Setting><Guidance:Waypoint.latitude/><Arg Name="Lat4"/></Setting>
<Setting><Guidance:Waypoint.longitude/><Arg Name="Lon4"/></Setting>
</Guidance:Waypoint>
</Aggregate>
<Aggregate Id="Wpt5">
<Sequence/>
<Guidance:Waypoint>
<Sequence/>
<Setting><Guidance:Waypoint.latitude/><Arg Name="Lat5"/></Setting>
<Setting><Guidance:Waypoint.longitude/><Arg Name="Lon5"/></Setting>
</Guidance:Waypoint>
</Aggregate>
<Aggregate Id="Wpt6">
<Sequence/>
<Guidance:Waypoint>
<Sequence/>
<Setting><Guidance:Waypoint.latitude/><Arg Name="Lat6"/></Setting>
<Setting><Guidance:Waypoint.longitude/><Arg Name="Lon6"/></Setting>
</Guidance:Waypoint>
</Aggregate>
<Aggregate Id="Wpt7">
<Sequence/>
<Guidance:Waypoint>
<Sequence/>
<Setting><Guidance:Waypoint.latitude/><Arg Name="Lat7"/></Setting>
<Setting><Guidance:Waypoint.longitude/><Arg Name="Lon7"/></Setting>
</Guidance:Waypoint>
</Aggregate>
</Aggregate>
</Mission>
2022-03-04T16:04:55.589Z,1646409895.589 [CommandExec](IMPORTANT): Loaded ./Missions/Science/sci2_flat_and_level.xml
2022-03-04T16:04:58.730Z,1646409898.730 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2022-03-04T16:04:58.730Z,1646409898.730 [RDI_Pathfinder] Data Fault, FailCount= 2
2022-03-04T16:04:58.730Z,1646409898.730 [RDI_Pathfinder](ERROR): Data Fault
2022-03-04T16:04:58.751Z,1646409898.751 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2022-03-04T16:04:59.137Z,1646409899.137 [RDI_Pathfinder](INFO): Powering down
2022-03-04T16:04:59.986Z,1646409899.986 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2022-03-04T16:04:59.986Z,1646409899.986 [RDI_Pathfinder] No Fault, FailCount= 2
2022-03-04T16:05:01.198Z,1646409901.198 [CommandExec](IMPORTANT): got command set sci2_flat_and_level.MissionTimeout 10.000000 minute
2022-03-04T16:05:01.199Z,1646409901.199 [CommandExec](IMPORTANT): got command set sci2_flat_and_level.Depth 0.200000 meter
2022-03-04T16:05:01.200Z,1646409901.200 [CommandExec](IMPORTANT): got command run
2022-03-04T16:05:01.208Z,1646409901.208 [CommandExec](IMPORTANT): Running
2022-03-04T16:05:01.573Z,1646409901.573 [Default] Stopped
2022-03-04T16:05:01.573Z,1646409901.573 [Default](DEBUG): Aggregate::uninitialize Default
2022-03-04T16:05:01.573Z,1646409901.573 [Default:B.GoToSurface] Stopped
2022-03-04T16:05:01.573Z,1646409901.573 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-03-04T16:05:01.573Z,1646409901.573 [Default:CheckIn] Stopped
2022-03-04T16:05:01.574Z,1646409901.574 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-03-04T16:05:01.574Z,1646409901.574 [Default:CheckIn:Read_GPS] Stopped
2022-03-04T16:05:01.574Z,1646409901.574 [MissionManager](IMPORTANT): Started mission sci2_flat_and_level
2022-03-04T16:05:01.574Z,1646409901.574 [sci2_flat_and_level] Running Loop=1
2022-03-04T16:05:01.574Z,1646409901.574 [sci2_flat_and_level](DEBUG): Aggregate::initialize sci2_flat_and_level
2022-03-04T16:05:01.574Z,1646409901.574 [sci2_flat_and_level:Science] Running Loop=1
2022-03-04T16:05:01.574Z,1646409901.574 [sci2_flat_and_level:Science](DEBUG): Aggregate::initialize sci2_flat_and_level:Science
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:A] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:B] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:C] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:D] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:E] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:F] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:G] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:H] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:Read_Oil] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:PeakDetectChl] Running Loop=1
2022-03-04T16:05:01.575Z,1646409901.575 [sci2_flat_and_level:Science:PeakDetectChl](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectChl
2022-03-04T16:05:01.576Z,1646409901.576 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2022-03-04T16:05:01.576Z,1646409901.576 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-03-04T16:05:01.578Z,1646409901.578 [sci2_flat_and_level:Science:HighestChlPeakReport] Running Loop=1
2022-03-04T16:05:01.578Z,1646409901.578 [sci2_flat_and_level:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:HighestChlPeakReport
2022-03-04T16:05:01.578Z,1646409901.578 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2022-03-04T16:05:01.578Z,1646409901.578 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2022-03-04T16:05:01.579Z,1646409901.579 [sci2_flat_and_level:Science:PeakDetectNO3] Running Loop=1
2022-03-04T16:05:01.579Z,1646409901.579 [sci2_flat_and_level:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectNO3
2022-03-04T16:05:01.579Z,1646409901.579 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2022-03-04T16:05:01.579Z,1646409901.579 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-03-04T16:05:01.649Z,1646409901.649 [sci2_flat_and_level:Science:PeakDetectOil] Running Loop=1
2022-03-04T16:05:01.649Z,1646409901.649 [sci2_flat_and_level:Science:PeakDetectOil](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectOil
2022-03-04T16:05:01.649Z,1646409901.649 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2022-03-04T16:05:01.649Z,1646409901.649 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-03-04T16:05:01.651Z,1646409901.651 [sci2_flat_and_level:Science:PeakDetectFDOM] Running Loop=1
2022-03-04T16:05:01.651Z,1646409901.651 [sci2_flat_and_level:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sci2_flat_and_level:Science:PeakDetectFDOM
2022-03-04T16:05:01.651Z,1646409901.651 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2022-03-04T16:05:01.656Z,1646409901.656 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-03-04T16:05:01.657Z,1646409901.657 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](CRITICAL): No UniversalURI called Universal:concentration_of_chromophoric_dissolved_organic_matter_in_sea_water
2022-03-04T16:05:01.657Z,1646409901.657 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](CRITICAL): Could not create Reader called Universal:concentration_of_chromophoric_dissolved_organic_matter_in_sea_water
2022-03-04T16:05:01.657Z,1646409901.657 [sci2_flat_and_level:StandardEnvelopes] Running Loop=1
2022-03-04T16:05:01.657Z,1646409901.657 [sci2_flat_and_level:StandardEnvelopes](DEBUG): Aggregate::initialize sci2_flat_and_level:StandardEnvelopes
2022-03-04T16:05:01.657Z,1646409901.657 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-03-04T16:05:01.657Z,1646409901.657 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2022-03-04T16:05:01.658Z,1646409901.658 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-03-04T16:05:01.658Z,1646409901.658 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2022-03-04T16:05:01.658Z,1646409901.658 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-03-04T16:05:01.658Z,1646409901.658 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2022-03-04T16:05:01.658Z,1646409901.658 [sci2_flat_and_level:C] Running Loop=1
2022-03-04T16:05:01.659Z,1646409901.659 [sci2_flat_and_level:SurfaceComms] Running Loop=1
2022-03-04T16:05:01.659Z,1646409901.659 [sci2_flat_and_level:SurfaceComms](DEBUG): Aggregate::initialize sci2_flat_and_level:SurfaceComms
2022-03-04T16:05:01.659Z,1646409901.659 [sci2_flat_and_level:SurfaceComms:A] Running Loop=1
2022-03-04T16:05:01.664Z,1646409901.664 [sci2_flat_and_level:SurfaceComms:A] Stopped
2022-03-04T16:05:01.664Z,1646409901.664 [sci2_flat_and_level:SurfaceComms:B] Running Loop=1
2022-03-04T16:05:01.664Z,1646409901.664 [sci2_flat_and_level:SurfaceComms:B](DEBUG): Aggregate::initialize sci2_flat_and_level:SurfaceComms:B
2022-03-04T16:05:01.664Z,1646409901.664 [sci2_flat_and_level:NeedComms] Running Loop=1
2022-03-04T16:05:01.664Z,1646409901.664 [sci2_flat_and_level:NeedComms](DEBUG): Aggregate::initialize sci2_flat_and_level:NeedComms
2022-03-04T16:05:01.665Z,1646409901.665 [sci2_flat_and_level:NeedComms:B.GoToSurface] Running Loop=1
2022-03-04T16:05:01.665Z,1646409901.665 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-03-04T16:05:01.665Z,1646409901.665 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2022-03-04T16:05:01.665Z,1646409901.665 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2022-03-04T16:05:01.666Z,1646409901.666 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2022-03-04T16:05:01.666Z,1646409901.666 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-03-04T16:05:01.667Z,1646409901.667 [sci2_flat_and_level:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-03-04T16:05:01.667Z,1646409901.667 [sci2_flat_and_level:NeedComms:A] Running Loop=1
2022-03-04T16:05:01.672Z,1646409901.672 [sci2_flat_and_level:NeedComms:A](ERROR): data element is not active.
2022-03-04T16:05:01.672Z,1646409901.672 [sci2_flat_and_level:NeedComms:A](INFO): last time_fix was: nan second since 1970/01/01T00:00:00Z
2022-03-04T16:05:01.672Z,1646409901.672 [sci2_flat_and_level:NeedComms:A] Stopped
2022-03-04T16:05:01.673Z,1646409901.673 [sci2_flat_and_level:C] Stopped
2022-03-04T16:05:01.673Z,1646409901.673 [sci2_flat_and_level:D] Running Loop=1
2022-03-04T16:05:01.673Z,1646409901.673 [sci2_flat_and_level:StandardEnvelopes] Running Loop=1
2022-03-04T16:05:01.673Z,1646409901.673 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-03-04T16:05:01.673Z,1646409901.673 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-03-04T16:05:01.674Z,1646409901.674 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-03-04T16:05:01.674Z,1646409901.674 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-03-04T16:05:01.675Z,1646409901.675 [sci2_flat_and_level:Science] Running Loop=1
2022-03-04T16:05:01.680Z,1646409901.680 [sci2_flat_and_level:Science:PeakDetectFDOM] Stopped
2022-03-04T16:05:01.680Z,1646409901.680 [sci2_flat_and_level:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectFDOM
2022-03-04T16:05:01.680Z,1646409901.680 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2022-03-04T16:05:01.680Z,1646409901.680 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-03-04T16:05:01.680Z,1646409901.680 [sci2_flat_and_level:Science:PeakDetectOil] Stopped
2022-03-04T16:05:01.680Z,1646409901.680 [sci2_flat_and_level:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectOil
2022-03-04T16:05:01.680Z,1646409901.680 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:PeakDetectNO3] Stopped
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectNO3
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:HighestChlPeakReport] Stopped
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:HighestChlPeakReport
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2022-03-04T16:05:01.681Z,1646409901.681 [sci2_flat_and_level:Science:PeakDetectChl] Stopped
2022-03-04T16:05:01.682Z,1646409901.682 [sci2_flat_and_level:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science:PeakDetectChl
2022-03-04T16:05:01.682Z,1646409901.682 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2022-03-04T16:05:01.682Z,1646409901.682 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-03-04T16:05:01.682Z,1646409901.682 [sci2_flat_and_level:Science:Read_Oil] Running Loop=1
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:H] Stopped
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:G] Stopped
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:F] Stopped
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:E] Stopped
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:D] Stopped
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:C] Stopped
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:B] Stopped
2022-03-04T16:05:01.683Z,1646409901.683 [sci2_flat_and_level:Science:A] Stopped
2022-03-04T16:05:01.701Z,1646409901.701 [CBIT](INFO): Critical error at 20220304T160501
2022-03-04T16:05:01.701Z,1646409901.701 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-03-04T16:05:01.978Z,1646409901.978 [sci2_flat_and_level:NeedComms:C] Running Loop=1
2022-03-04T16:05:01.978Z,1646409901.978 [sci2_flat_and_level:D] Stopped
2022-03-04T16:05:01.979Z,1646409901.979 [sci2_flat_and_level:E] Running Loop=1
2022-03-04T16:05:01.979Z,1646409901.979 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-03-04T16:05:01.985Z,1646409901.985 [MissionManager](INFO): MissionManager is completed.
2022-03-04T16:05:01.985Z,1646409901.985 [MissionManager](INFO): Uninitializing Mission sci2_flat_and_level
2022-03-04T16:05:01.985Z,1646409901.985 [sci2_flat_and_level] Stopped
2022-03-04T16:05:01.985Z,1646409901.985 [sci2_flat_and_level](DEBUG): Aggregate::uninitialize sci2_flat_and_level
2022-03-04T16:05:01.985Z,1646409901.985 [sci2_flat_and_level:Science] Stopped
2022-03-04T16:05:01.985Z,1646409901.985 [sci2_flat_and_level:Science](DEBUG): Aggregate::uninitialize sci2_flat_and_level:Science
2022-03-04T16:05:01.985Z,1646409901.985 [sci2_flat_and_level:Science:Read_Oil] Stopped
2022-03-04T16:05:01.985Z,1646409901.985 [sci2_flat_and_level:StandardEnvelopes] Stopped
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:StandardEnvelopes](DEBUG): Aggregate::uninitialize sci2_flat_and_level:StandardEnvelopes
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope] Stopped
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:E] Stopped
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:NeedComms] Stopped
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:NeedComms](DEBUG): Aggregate::uninitialize sci2_flat_and_level:NeedComms
2022-03-04T16:05:01.986Z,1646409901.986 [sci2_flat_and_level:NeedComms:B.GoToSurface] Stopped
2022-03-04T16:05:01.987Z,1646409901.987 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-03-04T16:05:01.987Z,1646409901.987 [sci2_flat_and_level:NeedComms:C] Stopped
2022-03-04T16:05:01.987Z,1646409901.987 [sci2_flat_and_level:SurfaceComms] Stopped
2022-03-04T16:05:01.987Z,1646409901.987 [sci2_flat_and_level:SurfaceComms](DEBUG): Aggregate::uninitialize sci2_flat_and_level:SurfaceComms
2022-03-04T16:05:01.987Z,1646409901.987 [sci2_flat_and_level:SurfaceComms:B] Stopped
2022-03-04T16:05:01.987Z,1646409901.987 [sci2_flat_and_level:SurfaceComms:B](DEBUG): Aggregate::uninitialize sci2_flat_and_level:SurfaceComms:B
2022-03-04T16:05:02.385Z,1646409902.385 [MissionManager](IMPORTANT): Started mission Default
2022-03-04T16:05:02.385Z,1646409902.385 [Default] Running Loop=1
2022-03-04T16:05:02.385Z,1646409902.385 [Default](DEBUG): Aggregate::initialize Default
2022-03-04T16:05:02.385Z,1646409902.385 [Default:B.GoToSurface] Running Loop=1
2022-03-04T16:05:02.385Z,1646409902.385 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-03-04T16:05:02.386Z,1646409902.386 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-03-04T16:05:02.386Z,1646409902.386 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-03-04T16:05:02.386Z,1646409902.386 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-03-04T16:05:02.387Z,1646409902.387 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-03-04T16:05:02.387Z,1646409902.387 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-03-04T16:05:02.387Z,1646409902.387 [Default:A.Wait] Running Loop=1
2022-03-04T16:05:02.388Z,1646409902.388 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-03-04T16:05:15.707Z,1646409915.707 [Default:A.Wait](INFO): Done Waiting.
2022-03-04T16:05:15.707Z,1646409915.707 [Default:A.Wait] Stopped
2022-03-04T16:05:15.707Z,1646409915.707 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-03-04T16:05:16.122Z,1646409916.122 [Default:CheckIn] Running Loop=1
2022-03-04T16:05:16.122Z,1646409916.122 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-03-04T16:05:16.122Z,1646409916.122 [Default:CheckIn:Read_GPS] Running Loop=1
2022-03-04T16:07:33.473Z,1646410053.473 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2022-03-04T16:07:33.473Z,1646410053.473 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:07:33.485Z,1646410053.485 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:07:33.894Z,1646410053.894 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:07:33.894Z,1646410053.894 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2022-03-04T16:08:13.054Z,1646410093.054 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2022-03-04T16:08:13.055Z,1646410093.055 [RDI_Pathfinder] Data Fault, FailCount= 3
2022-03-04T16:08:13.055Z,1646410093.055 [RDI_Pathfinder](ERROR): Data Fault
2022-03-04T16:08:13.104Z,1646410093.104 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2022-03-04T16:08:13.105Z,1646410093.105 [CBIT](CRITICAL): Data Fault in component: RDI_Pathfinder
2022-03-04T16:08:13.458Z,1646410093.458 [RDI_Pathfinder](INFO): Powering down
2022-03-04T16:08:13.481Z,1646410093.481 [CBIT](INFO): Critical error at 20220304T160813
2022-03-04T16:09:02.746Z,1646410142.746 [NAL9602](FAULT): GPS failed to acquire within timeout.
2022-03-04T16:09:02.746Z,1646410142.746 [NAL9602] Data Fault, FailCount= 1
2022-03-04T16:09:02.746Z,1646410142.746 [NAL9602](ERROR): Data Fault
2022-03-04T16:09:02.764Z,1646410142.764 [CBIT](ERROR): Data Fault in component: NAL9602
2022-03-04T16:09:03.150Z,1646410143.150 [NAL9602](INFO): Powering down
2022-03-04T16:09:03.974Z,1646410143.974 [CBIT](INFO): Clearing failed state for component NAL9602
2022-03-04T16:09:03.975Z,1646410143.975 [NAL9602] No Fault, FailCount= 1
2022-03-04T16:10:16.286Z,1646410216.286 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-03-04T16:05:16.1Z
2022-03-04T16:10:16.286Z,1646410216.286 [Default:CheckIn:Read_GPS] Stopped
2022-03-04T16:10:16.286Z,1646410216.286 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-03-04T16:10:16.698Z,1646410216.698 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-03-04T16:10:21.288Z,1646410221.288 [DataOverHttps](INFO): Sending 273 bytes from file Logs/20220304T155822/Courier0004.lzma
2022-03-04T16:10:22.289Z,1646410222.289 [DataOverHttps](INFO): Moved sent file to Logs/20220304T155822/Courier0004.lzma.bak
2022-03-04T16:10:22.290Z,1646410222.290 [DataOverHttps](INFO): SBD MOMSN=1758821
2022-03-04T16:10:32.479Z,1646410232.479 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20220304T155822/Courier0007.lzma
2022-03-04T16:10:33.483Z,1646410233.483 [DataOverHttps](INFO): Moved sent file to Logs/20220304T155822/Courier0007.lzma.bak
2022-03-04T16:10:33.483Z,1646410233.483 [DataOverHttps](INFO): SBD MOMSN=1758826
2022-03-04T16:10:34.466Z,1646410234.466 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2022-03-04T16:10:34.466Z,1646410234.466 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:10:34.477Z,1646410234.477 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:10:34.902Z,1646410234.902 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:10:34.903Z,1646410234.903 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2022-03-04T16:10:44.828Z,1646410244.828 [DataOverHttps](INFO): Sending 394 bytes from file Logs/20220304T155822/Express0005.lzma
2022-03-04T16:10:45.829Z,1646410245.829 [DataOverHttps](INFO): Moved sent file to Logs/20220304T155822/Express0005.lzma.bak
2022-03-04T16:10:45.830Z,1646410245.830 [DataOverHttps](INFO): SBD MOMSN=1758828
2022-03-04T16:10:49.421Z,1646410249.421 [Default:CheckIn:Read_Iridium] Stopped
2022-03-04T16:10:49.421Z,1646410249.421 [Default:CheckIn:C.Wait] Running Loop=1
2022-03-04T16:10:49.421Z,1646410249.421 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-03-04T16:11:13.268Z,1646410273.268 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2022-03-04T16:11:13.268Z,1646410273.268 [RDI_Pathfinder] No Fault, FailCount= 3
2022-03-04T16:13:35.464Z,1646410415.464 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2022-03-04T16:13:35.464Z,1646410415.464 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:13:35.476Z,1646410415.476 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:13:35.889Z,1646410415.889 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:13:35.889Z,1646410415.889 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2022-03-04T16:14:26.353Z,1646410466.353 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2022-03-04T16:14:26.353Z,1646410466.353 [RDI_Pathfinder] Data Fault, FailCount= 1
2022-03-04T16:14:26.354Z,1646410466.354 [RDI_Pathfinder](ERROR): Data Fault
2022-03-04T16:14:26.377Z,1646410466.377 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2022-03-04T16:14:26.754Z,1646410466.754 [RDI_Pathfinder](INFO): Powering down
2022-03-04T16:14:27.584Z,1646410467.584 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2022-03-04T16:14:27.584Z,1646410467.584 [RDI_Pathfinder] No Fault, FailCount= 1
2022-03-04T16:15:49.986Z,1646410549.986 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-03-04T16:15:49.986Z,1646410549.986 [Default:CheckIn:C.Wait] Stopped
2022-03-04T16:15:49.986Z,1646410549.986 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-03-04T16:15:49.986Z,1646410549.986 [Default:CheckIn:D] Running Loop=1
2022-03-04T16:15:50.401Z,1646410550.401 [Default:CheckIn:D] Stopped
2022-03-04T16:15:50.401Z,1646410550.401 [Default:CheckIn:E] Running Loop=1
2022-03-04T16:15:50.798Z,1646410550.798 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.800263 min
2022-03-04T16:15:50.798Z,1646410550.798 [Default:CheckIn:E] Stopped
2022-03-04T16:15:50.799Z,1646410550.799 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-03-04T16:15:50.799Z,1646410550.799 [Default:CheckIn] Stopped
2022-03-04T16:15:50.799Z,1646410550.799 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-03-04T16:15:50.799Z,1646410550.799 [Default:CheckIn](INFO): Running loop #2
2022-03-04T16:15:50.799Z,1646410550.799 [Default:CheckIn] Running Loop=2
2022-03-04T16:15:50.799Z,1646410550.799 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-03-04T16:15:50.799Z,1646410550.799 [Default:CheckIn:Read_GPS] Running Loop=1
2022-03-04T16:16:36.455Z,1646410596.455 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2022-03-04T16:16:36.455Z,1646410596.455 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:16:36.467Z,1646410596.467 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:16:36.885Z,1646410596.885 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:16:36.885Z,1646410596.885 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2022-03-04T16:17:40.676Z,1646410660.676 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2022-03-04T16:17:40.676Z,1646410660.676 [RDI_Pathfinder] Data Fault, FailCount= 2
2022-03-04T16:17:40.676Z,1646410660.676 [RDI_Pathfinder](ERROR): Data Fault
2022-03-04T16:17:40.697Z,1646410660.697 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2022-03-04T16:17:41.078Z,1646410661.078 [RDI_Pathfinder](INFO): Powering down
2022-03-04T16:17:41.904Z,1646410661.904 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2022-03-04T16:17:41.904Z,1646410661.904 [RDI_Pathfinder] No Fault, FailCount= 2
2022-03-04T16:19:05.918Z,1646410745.918 [NAL9602](FAULT): GPS failed to acquire within timeout.
2022-03-04T16:19:05.918Z,1646410745.918 [NAL9602] Data Fault, FailCount= 2
2022-03-04T16:19:05.918Z,1646410745.918 [NAL9602](ERROR): Data Fault
2022-03-04T16:19:05.974Z,1646410745.974 [CBIT](ERROR): Data Fault in component: NAL9602
2022-03-04T16:19:06.322Z,1646410746.322 [NAL9602](INFO): Powering down
2022-03-04T16:19:07.159Z,1646410747.159 [CBIT](INFO): Clearing failed state for component NAL9602
2022-03-04T16:19:07.159Z,1646410747.159 [NAL9602] No Fault, FailCount= 2
2022-03-04T16:19:37.441Z,1646410777.441 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2022-03-04T16:19:37.441Z,1646410777.441 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:19:37.452Z,1646410777.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:19:37.858Z,1646410777.858 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:19:37.858Z,1646410777.858 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2022-03-04T16:20:50.971Z,1646410850.971 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-03-04T16:15:50.8Z
2022-03-04T16:20:50.971Z,1646410850.971 [Default:CheckIn:Read_GPS] Stopped
2022-03-04T16:20:50.971Z,1646410850.971 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-03-04T16:20:54.998Z,1646410854.998 [RDI_Pathfinder](FAULT): DVL failed to acquire valid data within timeout.
2022-03-04T16:20:54.998Z,1646410854.998 [RDI_Pathfinder] Data Fault, FailCount= 3
2022-03-04T16:20:54.998Z,1646410854.998 [RDI_Pathfinder](ERROR): Data Fault
2022-03-04T16:20:55.048Z,1646410855.048 [CBIT](ERROR): Data Fault in component: RDI_Pathfinder
2022-03-04T16:20:55.048Z,1646410855.048 [CBIT](CRITICAL): Data Fault in component: RDI_Pathfinder
2022-03-04T16:20:55.403Z,1646410855.403 [RDI_Pathfinder](INFO): Powering down
2022-03-04T16:20:55.425Z,1646410855.425 [CBIT](INFO): Critical error at 20220304T162055
2022-03-04T16:20:56.212Z,1646410856.212 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20220304T155822/Courier0010.lzma
2022-03-04T16:20:57.214Z,1646410857.214 [DataOverHttps](INFO): Moved sent file to Logs/20220304T155822/Courier0010.lzma.bak
2022-03-04T16:20:57.214Z,1646410857.214 [DataOverHttps](INFO): SBD MOMSN=1758844
2022-03-04T16:21:08.647Z,1646410868.647 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20220304T155822/Express0011.lzma
2022-03-04T16:21:09.650Z,1646410869.650 [DataOverHttps](INFO): Moved sent file to Logs/20220304T155822/Express0011.lzma.bak
2022-03-04T16:21:09.650Z,1646410869.650 [DataOverHttps](INFO): SBD MOMSN=1758846
2022-03-04T16:21:13.209Z,1646410873.209 [Default:CheckIn:Read_Iridium] Stopped
2022-03-04T16:21:13.209Z,1646410873.209 [Default:CheckIn:C.Wait] Running Loop=1
2022-03-04T16:21:13.209Z,1646410873.209 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-03-04T16:22:25.484Z,1646410945.484 [CommandExec](IMPORTANT): got command failComponent
2022-03-04T16:22:25.485Z,1646410945.485 [CommandExec](IMPORTANT): Failed components:
2022-03-04T16:22:25.485Z,1646410945.485 [CommandExec](IMPORTANT): RDI_Pathfinder: Data Fault
2022-03-04T16:22:34.052Z,1646410954.052 [CommandExec](IMPORTANT): got command configSet list
2022-03-04T16:22:34.052Z,1646410954.052 [CommandExec](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-03-04T16:22:34.053Z,1646410954.053 [CommandExec](IMPORTANT): AHRS_M2.loadAtStartup=1 bool;
2022-03-04T16:22:34.053Z,1646410954.053 [CommandExec](IMPORTANT): AHRS_M2.simulateHardware= 0 bool;
2022-03-04T16:22:34.053Z,1646410954.053 [CommandExec](IMPORTANT): BuoyancyServo.loadAtStartup=1 bool;
2022-03-04T16:22:34.053Z,1646410954.053 [CommandExec](IMPORTANT): BuoyancyServo.offsetVolume=32 cubic_centimeter;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): DDM.loadAtStartup=0 bool;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): ElevatorServo.loadAtStartup=1 bool;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): ElevatorServo.simulateHardware=1 bool;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): MassServo.simulateHardware=1 bool;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): RudderServo.loadAtStartup=1 bool;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): RudderServo.simulateHardware=1 bool;
2022-03-04T16:22:34.054Z,1646410954.054 [CommandExec](IMPORTANT): ThrusterHE.loadAtStartup=0 bool;
2022-03-04T16:22:34.055Z,1646410954.055 [CommandExec](IMPORTANT): ThrusterServo.loadAtStartup=0 bool;
2022-03-04T16:22:34.055Z,1646410954.055 [CommandExec](IMPORTANT): VerticalControl.buoyancyNeutral=288.614464 cubic_centimeter;
2022-03-04T16:22:34.055Z,1646410954.055 [CommandExec](IMPORTANT): VerticalControl.massDefault=2.506765 millimeter;
2022-03-04T16:22:34.055Z,1646410954.055 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitAft=-29 millimeter;
2022-03-04T16:22:34.055Z,1646410954.055 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitFwd=30 millimeter;
2022-03-04T16:22:38.433Z,1646410958.433 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2022-03-04T16:22:38.433Z,1646410958.433 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-03-04T16:22:38.444Z,1646410958.444 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-03-04T16:22:38.852Z,1646410958.852 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-03-04T16:22:38.852Z,1646410958.852 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2022-03-04T16:23:03.004Z,1646410983.004 [CommandExec](IMPORTANT): got command get platform_elevator_angle degree
2022-03-04T16:23:03.005Z,1646410983.005 [CommandExec](FAULT): Element has no value
2022-03-04T16:23:27.834Z,1646411007.834 [CommandExec](IMPORTANT): got command get ElevatorServo.simulateHardware
2022-03-04T16:23:27.834Z,1646411007.834 [CommandExec](IMPORTANT): ElevatorServo.simulateHardware 1 bool
2022-03-04T16:23:55.213Z,1646411035.213 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2022-03-04T16:23:55.213Z,1646411035.213 [RDI_Pathfinder] No Fault, FailCount= 3
2022-03-04T16:24:05.702Z,1646411045.702 [CommandExec](IMPORTANT): got command configSet ElevatorServo.simulateHardware 0.000000 bool persist
2022-03-04T16:24:05.703Z,1646411045.703 [CommandExec](IMPORTANT): configSet ElevatorServo.simulateHardware requires a restart to take effect.
2022-03-04T16:24:10.941Z,1646411050.941 [CommandExec](IMPORTANT): got command restart application
2022-03-04T16:24:11.944Z,1646411051.944 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:11.944Z,1646411051.944 [CommandExec](INFO): Uninitializing the command executive.
2022-03-04T16:24:11.944Z,1646411051.944 [CommandExec](INFO): Uninitializing the command scheduler.
2022-03-04T16:24:11.945Z,1646411051.945 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:11.948Z,1646411051.948 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2022-03-04T16:24:11.948Z,1646411051.948 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-03-04T16:24:11.948Z,1646411051.948 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:11.949Z,1646411051.949 [NavChartDb](INFO): Join timeout helper Thread ID is 4391
2022-03-04T16:24:12.260Z,1646411052.260 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:12.260Z,1646411052.260 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:12.267Z,1646411052.267 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2022-03-04T16:24:12.267Z,1646411052.267 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:12.267Z,1646411052.267 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 4392
2022-03-04T16:24:12.292Z,1646411052.292 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:12.293Z,1646411052.293 [WetLabsSeaOWL_UV_A](INFO): Powering down
2022-03-04T16:24:12.293Z,1646411052.293 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:12.300Z,1646411052.300 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-03-04T16:24:12.300Z,1646411052.300 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:12.301Z,1646411052.301 [Radio_Surface](INFO): Join timeout helper Thread ID is 4393
2022-03-04T16:24:12.652Z,1646411052.652 [Radio_Surface](INFO): Powering down
2022-03-04T16:24:12.653Z,1646411052.653 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:12.653Z,1646411052.653 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:12.672Z,1646411052.672 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-03-04T16:24:12.672Z,1646411052.672 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:12.672Z,1646411052.672 [Onboard](INFO): Join timeout helper Thread ID is 4394
2022-03-04T16:24:13.096Z,1646411053.096 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-03-04T16:24:17.568Z,1646411057.568 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:17.568Z,1646411057.568 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:17.588Z,1646411057.588 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-03-04T16:24:17.589Z,1646411057.589 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:17.589Z,1646411057.589 [DataOverHttps](INFO): Join timeout helper Thread ID is 4395
2022-03-04T16:24:18.116Z,1646411058.116 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:18.116Z,1646411058.116 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.133Z,1646411058.133 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-03-04T16:24:18.133Z,1646411058.133 [logger ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.133Z,1646411058.133 [logger](INFO): Join timeout helper Thread ID is 4396
2022-03-04T16:24:18.148Z,1646411058.148 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:18.148Z,1646411058.148 [logger ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.152Z,1646411058.152 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-03-04T16:24:18.153Z,1646411058.153 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.153Z,1646411058.153 [CommandLine](INFO): Join timeout helper Thread ID is 4397
2022-03-04T16:24:18.192Z,1646411058.192 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:18.192Z,1646411058.192 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.221Z,1646411058.221 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-03-04T16:24:18.221Z,1646411058.221 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.221Z,1646411058.221 [CommandExec](INFO): Join timeout helper Thread ID is 4398
2022-03-04T16:24:18.225Z,1646411058.225 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-03-04T16:24:18.225Z,1646411058.225 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.225Z,1646411058.225 [controlThread](INFO): Join timeout helper Thread ID is 4399
2022-03-04T16:24:18.242Z,1646411058.242 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-03-04T16:24:18.242Z,1646411058.242 [controlThread](DEBUG): Uninitializing ControlThread
2022-03-04T16:24:18.242Z,1646411058.242 [AHRS_M2](INFO): Powering down
2022-03-04T16:24:18.312Z,1646411058.312 [NAL9602](INFO): Powering down
2022-03-04T16:24:18.313Z,1646411058.313 [RDI_Pathfinder](INFO): Powering down
2022-03-04T16:24:18.314Z,1646411058.314 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-03-04T16:24:18.315Z,1646411058.315 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-03-04T16:24:18.315Z,1646411058.315 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-03-04T16:24:18.316Z,1646411058.316 [MissionManager](INFO): Uninitializing Mission Default
2022-03-04T16:24:18.316Z,1646411058.316 [Default] Stopped
2022-03-04T16:24:18.316Z,1646411058.316 [Default](DEBUG): Aggregate::uninitialize Default
2022-03-04T16:24:18.316Z,1646411058.316 [Default:B.GoToSurface] Stopped
2022-03-04T16:24:18.316Z,1646411058.316 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-03-04T16:24:18.316Z,1646411058.316 [Default:CheckIn] Stopped
2022-03-04T16:24:18.317Z,1646411058.317 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-03-04T16:24:18.317Z,1646411058.317 [Default:CheckIn:C.Wait] Stopped
2022-03-04T16:24:18.317Z,1646411058.317 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-03-04T16:24:18.320Z,1646411058.320 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-03-04T16:24:18.320Z,1646411058.320 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-03-04T16:24:18.321Z,1646411058.321 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-03-04T16:24:18.321Z,1646411058.321 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-03-04T16:24:18.321Z,1646411058.321 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-03-04T16:24:18.321Z,1646411058.321 [BuoyancyServo](INFO): Powering down
2022-03-04T16:24:18.336Z,1646411058.336 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-03-04T16:24:18.336Z,1646411058.336 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-03-04T16:24:18.337Z,1646411058.337 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-03-04T16:24:18.337Z,1646411058.337 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-03-04T16:24:18.337Z,1646411058.337 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-03-04T16:24:18.338Z,1646411058.338 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-03-04T16:24:18.338Z,1646411058.338 [CBIT](DEBUG): Powering off loads.
2022-03-04T16:24:18.352Z,1646411058.352 [CBIT](DEBUG): Disabling WDT.
2022-03-04T16:24:18.364Z,1646411058.364 [CBIT](DEBUG): Opening all GF detection circuits.
2022-03-04T16:24:18.365Z,1646411058.365 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.429Z,1646411058.429 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.431Z,1646411058.431 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.437Z,1646411058.437 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.528Z,1646411058.528 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.537Z,1646411058.537 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-03-04T16:24:18.600Z,1646411058.600 [logger ThreadHandler](INFO): Thread cancelled.