2021-11-29T16:18:30.610Z,1638202710.610 [Supervisor](DEBUG): Initializing supervisor.
2021-11-29T16:18:30.616Z,1638202710.616 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-11-29T16:18:30.616Z,1638202710.616 [SyncHandler](INFO): Protected caller Thread ID is 9242
2021-11-29T16:18:30.617Z,1638202710.617 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-11-29T16:18:30.618Z,1638202710.618 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-11-29T16:18:30.618Z,1638202710.618 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9243
2021-11-29T16:18:30.622Z,1638202710.622 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-11-29T16:18:30.641Z,1638202710.641 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2021-11-29T16:18:30.642Z,1638202710.642 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-11-29T16:18:30.642Z,1638202710.642 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9244
2021-11-29T16:18:30.647Z,1638202710.647 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-11-29T16:18:30.648Z,1638202710.648 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-11-29T16:18:30.648Z,1638202710.648 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9245
2021-11-29T16:18:30.650Z,1638202710.650 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-11-29T16:18:30.651Z,1638202710.651 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2021-11-29T16:18:30.651Z,1638202710.651 [logger ThreadHandler](INFO): Protected caller Thread ID is 9246
2021-11-29T16:18:30.655Z,1638202710.655 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-11-29T16:18:30.656Z,1638202710.656 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-11-29T16:18:30.657Z,1638202710.657 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-11-29T16:18:30.882Z,1638202710.882 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-11-29T16:18:30.883Z,1638202710.883 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-11-29T16:18:30.963Z,1638202710.963 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-11-29T16:18:31.467Z,1638202711.467 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-11-29T16:18:31.468Z,1638202711.468 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-11-29T16:18:31.785Z,1638202711.785 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-11-29T16:18:31.786Z,1638202711.786 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-11-29T16:18:32.708Z,1638202712.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-11-29T16:18:32.709Z,1638202712.709 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-11-29T16:18:33.068Z,1638202713.068 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-11-29T16:18:33.069Z,1638202713.069 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-11-29T16:18:33.261Z,1638202713.261 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-11-29T16:18:33.262Z,1638202713.262 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-11-29T16:18:33.706Z,1638202713.706 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-11-29T16:18:33.707Z,1638202713.707 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-11-29T16:18:33.832Z,1638202713.832 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-11-29T16:18:33.832Z,1638202713.832 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-11-29T16:18:33.911Z,1638202713.911 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-11-29T16:18:34.559Z,1638202714.559 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-11-29T16:18:34.560Z,1638202714.560 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-11-29T16:18:34.911Z,1638202714.911 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-11-29T16:18:34.911Z,1638202714.911 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-11-29T16:18:35.096Z,1638202715.096 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-11-29T16:18:35.096Z,1638202715.096 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-11-29T16:18:35.205Z,1638202715.205 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-11-29T16:18:35.206Z,1638202715.206 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-11-29T16:18:35.358Z,1638202715.358 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-11-29T16:18:35.358Z,1638202715.358 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-11-29T16:18:35.578Z,1638202715.578 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-11-29T16:18:35.580Z,1638202715.580 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2021-11-29T16:18:35.581Z,1638202715.581 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2021-11-29T16:18:35.670Z,1638202715.670 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2021-11-29T16:18:35.755Z,1638202715.755 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2021-11-29T16:18:35.853Z,1638202715.853 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2021-11-29T16:18:35.935Z,1638202715.935 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2021-11-29T16:18:36.028Z,1638202716.028 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2021-11-29T16:18:36.127Z,1638202716.127 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2021-11-29T16:18:36.306Z,1638202716.306 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2021-11-29T16:18:36.381Z,1638202716.381 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2021-11-29T16:18:36.524Z,1638202716.524 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2021-11-29T16:18:36.657Z,1638202716.657 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2021-11-29T16:18:36.770Z,1638202716.770 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2021-11-29T16:18:37.353Z,1638202717.353 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-11-29T16:18:37.354Z,1638202717.354 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2021-11-29T16:18:37.355Z,1638202717.355 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-11-29T16:18:37.839Z,1638202717.839 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-11-29T16:18:37.916Z,1638202717.916 [VerticalControl](DEBUG): Construct VerticalControl.
2021-11-29T16:18:37.977Z,1638202717.977 [VerticalControl] Loaded
2021-11-29T16:18:37.977Z,1638202717.977 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-11-29T16:18:37.980Z,1638202717.980 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-11-29T16:18:38.017Z,1638202718.017 [HorizontalControl] Loaded
2021-11-29T16:18:38.018Z,1638202718.018 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-11-29T16:18:38.020Z,1638202718.020 [SpeedControl](DEBUG): Construct SpeedControl.
2021-11-29T16:18:38.023Z,1638202718.023 [SpeedControl] Loaded
2021-11-29T16:18:38.024Z,1638202718.024 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-11-29T16:18:38.026Z,1638202718.026 [LoopControl](DEBUG): Construct LoopControl.
2021-11-29T16:18:38.027Z,1638202718.027 [LoopControl] Loaded
2021-11-29T16:18:38.027Z,1638202718.027 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-11-29T16:18:38.027Z,1638202718.027 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-11-29T16:18:38.028Z,1638202718.028 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-11-29T16:18:38.039Z,1638202718.039 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-11-29T16:18:38.039Z,1638202718.039 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-11-29T16:18:38.150Z,1638202718.150 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-11-29T16:18:38.151Z,1638202718.151 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-11-29T16:18:38.286Z,1638202718.286 [BuoyancyServo] Loaded
2021-11-29T16:18:38.286Z,1638202718.286 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-11-29T16:18:38.305Z,1638202718.305 [ElevatorServo] Loaded
2021-11-29T16:18:38.305Z,1638202718.305 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-11-29T16:18:38.324Z,1638202718.324 [MassServo] Loaded
2021-11-29T16:18:38.324Z,1638202718.324 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-11-29T16:18:38.342Z,1638202718.342 [RudderServo] Loaded
2021-11-29T16:18:38.342Z,1638202718.342 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-11-29T16:18:38.360Z,1638202718.360 [ThrusterServo] Loaded
2021-11-29T16:18:38.360Z,1638202718.360 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2021-11-29T16:18:38.361Z,1638202718.361 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-11-29T16:18:38.361Z,1638202718.361 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-11-29T16:18:38.445Z,1638202718.445 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-11-29T16:18:38.446Z,1638202718.446 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-11-29T16:18:38.459Z,1638202718.459 [NavChart] Loaded
2021-11-29T16:18:38.459Z,1638202718.459 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-11-29T16:18:38.465Z,1638202718.465 [UniversalFixResidualReporter] Loaded
2021-11-29T16:18:38.465Z,1638202718.465 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-11-29T16:18:38.465Z,1638202718.465 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-11-29T16:18:38.466Z,1638202718.466 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-11-29T16:18:38.542Z,1638202718.542 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-11-29T16:18:38.543Z,1638202718.543 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-11-29T16:18:39.067Z,1638202719.067 [AHRS_M2] Loaded
2021-11-29T16:18:39.067Z,1638202719.067 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2021-11-29T16:18:39.871Z,1638202719.871 [BPC1] Loaded
2021-11-29T16:18:39.871Z,1638202719.871 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-11-29T16:18:39.891Z,1638202719.891 [Depth_Keller] Loaded
2021-11-29T16:18:39.891Z,1638202719.891 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-11-29T16:18:39.896Z,1638202719.896 [DropWeight] Loaded
2021-11-29T16:18:39.896Z,1638202719.896 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2021-11-29T16:18:39.956Z,1638202719.956 [NAL9602] Loaded
2021-11-29T16:18:39.956Z,1638202719.956 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-11-29T16:18:39.985Z,1638202719.985 [Onboard] Loaded
2021-11-29T16:18:39.985Z,1638202719.985 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-11-29T16:18:39.987Z,1638202719.987 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408C64E0
2021-11-29T16:18:39.987Z,1638202719.987 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9332
2021-11-29T16:18:39.000Z,1638202720.000 [Power24vConverter] Loaded
2021-11-29T16:18:40.000Z,1638202720.000 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2021-11-29T16:18:40.014Z,1638202720.014 [Radio_Surface] Loaded
2021-11-29T16:18:40.015Z,1638202720.015 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-11-29T16:18:40.016Z,1638202720.016 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408F64E0
2021-11-29T16:18:40.016Z,1638202720.016 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9333
2021-11-29T16:18:40.097Z,1638202720.097 [DAT] Loaded
2021-11-29T16:18:40.097Z,1638202720.097 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2021-11-29T16:18:40.098Z,1638202720.098 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-11-29T16:18:40.098Z,1638202720.098 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-11-29T16:18:40.161Z,1638202720.161 [DepthRateCalculator] Loaded
2021-11-29T16:18:40.161Z,1638202720.161 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-11-29T16:18:40.166Z,1638202720.166 [PitchRateCalculator] Loaded
2021-11-29T16:18:40.166Z,1638202720.166 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-11-29T16:18:40.175Z,1638202720.175 [SpeedCalculator] Loaded
2021-11-29T16:18:40.175Z,1638202720.175 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-11-29T16:18:40.189Z,1638202720.189 [TempGradientCalculator] Loaded
2021-11-29T16:18:40.189Z,1638202720.189 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-11-29T16:18:40.193Z,1638202720.193 [YawRateCalculator] Loaded
2021-11-29T16:18:40.194Z,1638202720.194 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-11-29T16:18:40.212Z,1638202720.212 [ElevatorOffsetCalculator] Loaded
2021-11-29T16:18:40.212Z,1638202720.212 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-11-29T16:18:40.212Z,1638202720.212 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-11-29T16:18:40.213Z,1638202720.213 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-11-29T16:18:40.535Z,1638202720.535 [CANONSampler] Loaded
2021-11-29T16:18:40.535Z,1638202720.535 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2021-11-29T16:18:40.614Z,1638202720.614 [CTD_Seabird] Loaded
2021-11-29T16:18:40.615Z,1638202720.615 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2021-11-29T16:18:40.616Z,1638202720.616 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409AB4E0
2021-11-29T16:18:40.616Z,1638202720.616 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9334
2021-11-29T16:18:40.636Z,1638202720.636 [PAR_Licor] Loaded
2021-11-29T16:18:40.636Z,1638202720.636 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2021-11-29T16:18:40.668Z,1638202720.668 [WetLabsBB2FL] Loaded
2021-11-29T16:18:40.668Z,1638202720.668 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2021-11-29T16:18:40.669Z,1638202720.669 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0
2021-11-29T16:18:40.670Z,1638202720.670 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9335
2021-11-29T16:18:40.671Z,1638202720.671 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-11-29T16:18:40.671Z,1638202720.671 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-11-29T16:18:40.714Z,1638202720.714 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-11-29T16:18:40.714Z,1638202720.714 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-11-29T16:18:41.107Z,1638202721.107 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-11-29T16:18:41.107Z,1638202721.107 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-11-29T16:18:41.292Z,1638202721.292 [SBIT](DEBUG): Construct Startup Built In Test.
2021-11-29T16:18:41.301Z,1638202721.301 [SBIT] Loaded
2021-11-29T16:18:41.302Z,1638202721.302 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-11-29T16:18:41.304Z,1638202721.304 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-11-29T16:18:41.318Z,1638202721.318 [IBIT] Loaded
2021-11-29T16:18:41.318Z,1638202721.318 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-11-29T16:18:41.324Z,1638202721.324 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-11-29T16:18:41.426Z,1638202721.426 [CBIT] Loaded
2021-11-29T16:18:41.427Z,1638202721.427 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-11-29T16:18:41.427Z,1638202721.427 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-11-29T16:18:41.428Z,1638202721.428 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-11-29T16:18:41.549Z,1638202721.549 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-11-29T16:18:41.556Z,1638202721.556 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-11-29T16:18:41.559Z,1638202721.559 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-11-29T16:18:41.569Z,1638202721.569 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-11-29T16:18:41.572Z,1638202721.572 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B104E0
2021-11-29T16:18:41.572Z,1638202721.572 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9336
2021-11-29T16:18:41.577Z,1638202721.577 [Supervisor](INFO): Main Thread ID is 9241
2021-11-29T16:18:41.577Z,1638202721.577 [Supervisor](DEBUG): Running supervisor.
2021-11-29T16:18:41.578Z,1638202721.578 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9337
2021-11-29T16:18:41.579Z,1638202721.579 [CommandExec](INFO): Initializing the command executive.
2021-11-29T16:18:41.581Z,1638202721.581 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9338
2021-11-29T16:18:41.583Z,1638202721.583 [controlThread ThreadHandler](INFO): Handler Thread ID is 9339
2021-11-29T16:18:41.583Z,1638202721.583 [controlThread](DEBUG): Initializing ControlThread
2021-11-29T16:18:41.584Z,1638202721.584 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-11-29T16:18:41.586Z,1638202721.586 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-11-29T16:18:41.587Z,1638202721.587 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-11-29T16:18:41.587Z,1638202721.587 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-11-29T16:18:41.590Z,1638202721.590 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-11-29T16:18:41.590Z,1638202721.590 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-11-29T16:18:41.596Z,1638202721.596 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-11-29T16:18:41.597Z,1638202721.597 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-11-29T16:18:41.597Z,1638202721.597 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-11-29T16:18:41.597Z,1638202721.597 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-11-29T16:18:41.598Z,1638202721.598 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-11-29T16:18:41.598Z,1638202721.598 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-11-29T16:18:41.603Z,1638202721.603 [SBIT](INFO): Initialize SBIT Component.
2021-11-29T16:18:41.603Z,1638202721.603 [SBIT](IMPORTANT): git: 2021-11-29
2021-11-29T16:18:41.603Z,1638202721.603 [SBIT](INFO): git hash: f462e1af5d4560b0531ff1e41adede0f51e7b106
2021-11-29T16:18:41.604Z,1638202721.604 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-11-29T16:18:41.605Z,1638202721.605 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2021-11-29T16:18:41.607Z,1638202721.607 [logger ThreadHandler](INFO): Handler Thread ID is 9340
2021-11-29T16:18:41.622Z,1638202721.622 [SBIT](INFO): Beginning SBIT in 84.000000 seconds.
2021-11-29T16:18:41.623Z,1638202721.623 [IBIT](INFO): Initialize IBIT Component.
2021-11-29T16:18:41.624Z,1638202721.624 [CBIT](DEBUG): Initialize CBIT Component.
2021-11-29T16:18:41.631Z,1638202721.631 [Onboard ThreadHandler](INFO): Handler Thread ID is 9341
2021-11-29T16:18:41.639Z,1638202721.639 [CBIT](DEBUG): Initialized mux pins.
2021-11-29T16:18:41.639Z,1638202721.639 [CBIT](DEBUG): Initializing the watchdog timer.
2021-11-29T16:18:41.652Z,1638202721.652 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9342
2021-11-29T16:18:41.662Z,1638202721.662 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-11-29T16:18:41.663Z,1638202721.663 [CBIT](DEBUG): Initializing heartbeat.
2021-11-29T16:18:41.667Z,1638202721.667 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9343
2021-11-29T16:18:41.667Z,1638202721.667 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-11-29T16:18:41.672Z,1638202721.672 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9345
2021-11-29T16:18:41.675Z,1638202721.675 [WetLabsBB2FL](INFO): Powering up
2021-11-29T16:18:41.676Z,1638202721.676 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9347
2021-11-29T16:18:41.681Z,1638202721.681 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-11-29T16:18:41.681Z,1638202721.681 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-11-29T16:18:41.681Z,1638202721.681 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-11-29T16:18:41.681Z,1638202721.681 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-11-29T16:18:41.682Z,1638202721.682 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-11-29T16:18:41.682Z,1638202721.682 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-11-29T16:18:41.683Z,1638202721.683 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-11-29T16:18:41.683Z,1638202721.683 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-11-29T16:18:41.684Z,1638202721.684 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-11-29T16:18:41.684Z,1638202721.684 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-11-29T16:18:41.684Z,1638202721.684 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-11-29T16:18:41.684Z,1638202721.684 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-11-29T16:18:41.684Z,1638202721.684 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-11-29T16:18:41.684Z,1638202721.684 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-11-29T16:18:41.685Z,1638202721.685 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-11-29T16:18:41.685Z,1638202721.685 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-11-29T16:18:41.734Z,1638202721.734 [CBIT](DEBUG): Deactivating GF circuits.
2021-11-29T16:18:41.735Z,1638202721.735 [CBIT](DEBUG): Deactivating emergency mode.
2021-11-29T16:18:41.770Z,1638202721.770 [CBIT](DEBUG): Backplane powered.
2021-11-29T16:18:41.771Z,1638202721.771 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-11-29T16:18:41.807Z,1638202721.807 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-11-29T16:18:41.835Z,1638202721.835 [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>


2021-11-29T16:18:41.836Z,1638202721.836 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2021-11-29T16:18:41.925Z,1638202721.925 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-11-29T16:18:41.926Z,1638202721.926 [Default:A.Wait](DEBUG): Construct Wait.
2021-11-29T16:18:41.928Z,1638202721.928 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-11-29T16:18:41.971Z,1638202721.971 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-11-29T16:18:41.973Z,1638202721.973 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-11-29T16:18:41.000Z,1638202722.000 [Default:E.Execute](DEBUG): Construct Execute.
2021-11-29T16:18:42.014Z,1638202722.014 [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>


2021-11-29T16:18:42.034Z,1638202722.034 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-11-29T16:18:42.047Z,1638202722.047 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-11-29T16:18:42.058Z,1638202722.058 [Radio_Surface](INFO): Powering up
2021-11-29T16:18:42.117Z,1638202722.117 [Power24vConverter](INFO): Powering up.
2021-11-29T16:18:42.118Z,1638202722.118 [DAT](INFO): Powering up
2021-11-29T16:18:42.118Z,1638202722.118 [DAT](DEBUG): Initializing DAT.
2021-11-29T16:18:42.146Z,1638202722.146 [CANONSampler](INFO): Powering down
2021-11-29T16:18:42.181Z,1638202722.181 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-11-29T16:18:42.206Z,1638202722.206 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-11-29T16:18:42.208Z,1638202722.208 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-11-29T16:18:42.214Z,1638202722.214 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-11-29T16:18:42.215Z,1638202722.215 [MassServo](DEBUG): Initializing EZServoServo.
2021-11-29T16:18:42.223Z,1638202722.223 [MassServo](DEBUG): Initializing MassServo.
2021-11-29T16:18:42.223Z,1638202722.223 [RudderServo](DEBUG): Initializing EZServoServo.
2021-11-29T16:18:42.230Z,1638202722.230 [RudderServo](DEBUG): Initializing RudderServo.
2021-11-29T16:18:42.231Z,1638202722.231 [ThrusterServo](DEBUG): Initializing EZServoServo.
2021-11-29T16:18:42.238Z,1638202722.238 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2021-11-29T16:18:43.182Z,1638202723.182 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2021-11-29T16:18:43.182Z,1638202723.182 [RudderServo](FAULT): Rudder failed to initialize
2021-11-29T16:18:43.182Z,1638202723.182 [RudderServo] Communications Fault, FailCount= 1
2021-11-29T16:18:43.183Z,1638202723.183 [RudderServo](ERROR): Communications Fault
2021-11-29T16:18:43.282Z,1638202723.282 [CBIT](ERROR): Communications Fault in component: RudderServo
2021-11-29T16:18:43.491Z,1638202723.491 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-11-29T16:18:43.492Z,1638202723.492 [RudderServo](INFO): Powering down
2021-11-29T16:18:43.802Z,1638202723.802 [WetLabsBB2FL](INFO): Powering down
2021-11-29T16:18:44.127Z,1638202724.127 [RudderServo](DEBUG): Initializing EZServoServo.
2021-11-29T16:18:44.247Z,1638202724.247 [RudderServo](DEBUG): Initializing RudderServo.
2021-11-29T16:18:44.251Z,1638202724.251 [CBIT](INFO): Clearing failed state for component RudderServo
2021-11-29T16:18:44.251Z,1638202724.251 [RudderServo] No Fault, FailCount= 1
2021-11-29T16:18:45.634Z,1638202725.634 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-11-29T16:18:46.038Z,1638202726.038 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-11-29T16:18:46.554Z,1638202726.554 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-11-29T16:18:54.148Z,1638202734.148 [DAT](INFO): DAT read: 

2021-11-29T16:18:54.151Z,1638202734.151 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2021-11-29T16:18:55.765Z,1638202735.765 [DAT](INFO): DAT read: MF Frequency Band

2021-11-29T16:18:55.766Z,1638202735.766 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.14.2

2021-11-29T16:18:55.767Z,1638202735.767 [DAT](INFO): DAT read: Nov 29 2021 16:18:14 

2021-11-29T16:18:56.973Z,1638202736.973 [DAT](INFO): DAT read: Features enabled [Bearing]

2021-11-29T16:18:56.974Z,1638202736.974 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T16:18:56.974Z,1638202736.974 [DAT](INFO): commRate: 1200
2021-11-29T16:18:58.992Z,1638202738.992 [DAT](INFO): entering command mode
2021-11-29T16:18:59.396Z,1638202739.396 [DAT](INFO): DAT read: 

2021-11-29T16:18:59.397Z,1638202739.397 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:18:59.800Z,1638202739.800 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:00.204Z,1638202740.204 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:00.608Z,1638202740.608 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:01.012Z,1638202741.012 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:01.416Z,1638202741.416 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:01.820Z,1638202741.820 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:02.228Z,1638202742.228 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:02.629Z,1638202742.629 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:03.032Z,1638202743.032 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:03.436Z,1638202743.436 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:03.840Z,1638202743.840 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:04.248Z,1638202744.248 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:04.648Z,1638202744.648 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:05.052Z,1638202745.052 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:05.456Z,1638202745.456 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:05.860Z,1638202745.860 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:06.271Z,1638202746.271 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:06.668Z,1638202746.668 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:07.072Z,1638202747.072 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:07.484Z,1638202747.484 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:07.880Z,1638202747.880 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:08.284Z,1638202748.284 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:08.688Z,1638202748.688 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:09.096Z,1638202749.096 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:09.496Z,1638202749.496 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:09.900Z,1638202749.900 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:10.304Z,1638202750.304 [NAL9602](INFO): Powering up NAL9602
2021-11-29T16:19:10.306Z,1638202750.306 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:10.712Z,1638202750.712 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:11.112Z,1638202751.112 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:11.516Z,1638202751.516 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:11.920Z,1638202751.920 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:12.328Z,1638202752.328 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:12.728Z,1638202752.728 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:13.132Z,1638202753.132 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:13.536Z,1638202753.536 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:13.940Z,1638202753.940 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:14.344Z,1638202754.344 [DAT](DEBUG): checking for command mode acknowledgment
2021-11-29T16:19:14.344Z,1638202754.344 [DAT](FAULT): failed to enter command mode
2021-11-29T16:19:14.748Z,1638202754.748 [DAT](INFO): entering command mode
2021-11-29T16:19:15.153Z,1638202755.153 [DAT](INFO): DAT read: user:1>

2021-11-29T16:19:15.154Z,1638202755.154 [DAT](INFO): DAT read: Command '+++' not found

2021-11-29T16:19:15.155Z,1638202755.155 [DAT](INFO): DAT read: Error

2021-11-29T16:19:15.155Z,1638202755.155 [DAT](INFO): setting verbose to 3
2021-11-29T16:19:15.556Z,1638202755.556 [DAT](INFO): DAT read: user:2>

2021-11-29T16:19:15.557Z,1638202755.557 [DAT](INFO): DAT read: Verbose         | 3           

2021-11-29T16:19:15.558Z,1638202755.558 [DAT](INFO): set verbose to 3
2021-11-29T16:19:15.558Z,1638202755.558 [DAT](INFO): setting DatVerbose to 27440
2021-11-29T16:19:15.960Z,1638202755.960 [DAT](INFO): DAT read: user:3>

2021-11-29T16:19:15.962Z,1638202755.962 [DAT](INFO): DAT read: DatVerbose      | 27440       

2021-11-29T16:19:15.994Z,1638202755.994 [DAT](INFO): set DatVerbose to 27440
2021-11-29T16:19:15.995Z,1638202755.995 [DAT](INFO): setting transmit power to 8
2021-11-29T16:19:16.365Z,1638202756.365 [DAT](INFO): DAT read: user:4>

2021-11-29T16:19:16.366Z,1638202756.366 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2021-11-29T16:19:16.366Z,1638202756.366 [DAT](INFO): set transmit power to 8
2021-11-29T16:19:16.366Z,1638202756.366 [DAT](INFO): setting local address to 7
2021-11-29T16:19:16.769Z,1638202756.769 [DAT](INFO): DAT read: user:5>

2021-11-29T16:19:16.770Z,1638202756.770 [DAT](INFO): DAT read: LocalAddr       | 7           

2021-11-29T16:19:16.770Z,1638202756.770 [DAT](INFO): set local address to 7
2021-11-29T16:19:21.212Z,1638202761.212 [NAL9602](INFO): NAL9602 initialized
2021-11-29T16:19:48.313Z,1638202788.313 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:20:06.098Z,1638202806.098 [SBIT](IMPORTANT): Beginning Startup BIT
2021-11-29T16:20:06.103Z,1638202806.103 [CBIT](IMPORTANT): Beginning ground fault scan
2021-11-29T16:20:11.788Z,1638202811.788 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:20:17.433Z,1638202817.433 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.011759
CHAN A1 (24V): 0.000601
CHAN A2 (12V): -0.002038
CHAN A3 (5V): -0.001701
CHAN B0 (3.3V): -0.000215
CHAN B1 (3.15aV): 0.000130
CHAN B2 (3.15bV): -0.000428
CHAN B3 (GND): 0.000220
OPEN: -0.000392
Full Scale: +/- 1 mA
2021-11-29T16:20:48.525Z,1638202848.525 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:21:00.245Z,1638202860.245 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:21:00.270Z,1638202860.270 [SBIT](IMPORTANT): SBIT PASSED
2021-11-29T16:21:00.270Z,1638202860.270 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2021-11-29T16:21:00.271Z,1638202860.271 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool;

2021-11-29T16:21:00.271Z,1638202860.271 [SBIT](IMPORTANT): BuoyancyServo.fastPumpDepth=6 meter;

2021-11-29T16:21:00.271Z,1638202860.271 [SBIT](IMPORTANT): CANONSampler.loadAtStartup=1 bool;

2021-11-29T16:21:00.271Z,1638202860.271 [SBIT](IMPORTANT): DAT.baud=9600 bit_per_second;

2021-11-29T16:21:00.271Z,1638202860.271 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;

2021-11-29T16:21:00.272Z,1638202860.272 [SBIT](IMPORTANT): DAT.sbdAddress=1 enum;

2021-11-29T16:21:00.272Z,1638202860.272 [SBIT](IMPORTANT): DAT.surfaceThreshold=0 meter;

2021-11-29T16:21:00.272Z,1638202860.272 [SBIT](IMPORTANT): DAT.verbosity=3 count;

2021-11-29T16:21:00.272Z,1638202860.272 [SBIT](IMPORTANT): DataOverHttps.loadAtStartup=0 bool;

2021-11-29T16:21:00.272Z,1638202860.272 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=0 bool;

2021-11-29T16:21:00.272Z,1638202860.272 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2021-11-29T16:21:00.272Z,1638202860.272 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=296 cubic_centimeter;

2021-11-29T16:21:00.273Z,1638202860.273 [SBIT](IMPORTANT): VerticalControl.massDefault=-16 millimeter;

2021-11-29T16:21:00.273Z,1638202860.273 [SBIT](IMPORTANT): VerticalControl.surfaceThreshold=2 meter;

2021-11-29T16:21:00.655Z,1638202860.655 [MissionManager](IMPORTANT): Started mission Startup
2021-11-29T16:21:00.655Z,1638202860.655 [Startup] Running Loop=1
2021-11-29T16:21:00.656Z,1638202860.656 [Startup](DEBUG): Aggregate::initialize Startup
2021-11-29T16:21:00.656Z,1638202860.656 [Startup:A.GoToSurface] Running Loop=1
2021-11-29T16:21:00.656Z,1638202860.656 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-11-29T16:21:00.656Z,1638202860.656 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-11-29T16:21:00.657Z,1638202860.657 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-11-29T16:21:00.657Z,1638202860.657 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-11-29T16:21:00.658Z,1638202860.658 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-11-29T16:21:00.658Z,1638202860.658 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-11-29T16:21:00.660Z,1638202860.660 [Startup:StartupSatComms] Running Loop=1
2021-11-29T16:21:00.660Z,1638202860.660 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2021-11-29T16:21:00.660Z,1638202860.660 [Startup:StartupSatComms:A] Running Loop=1
2021-11-29T16:21:01.025Z,1638202861.025 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2021-11-29T16:21:41.848Z,1638202901.848 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2021-11-29T16:21:41.848Z,1638202901.848 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:21:41.859Z,1638202901.859 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:21:42.225Z,1638202902.225 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:21:42.225Z,1638202902.225 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2021-11-29T16:22:00.817Z,1638202920.817 [Startup:StartupSatComms:A](INFO): Timed out from 2021-11-29T16:21:00.7Z
2021-11-29T16:22:00.817Z,1638202920.817 [Startup:StartupSatComms:A] Stopped
2021-11-29T16:22:00.817Z,1638202920.817 [Startup:StartupSatComms:B] Running Loop=1
2021-11-29T16:22:01.225Z,1638202921.225 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2021-11-29T16:22:01.634Z,1638202921.634 [DAT](INFO): #Outgoing data=1
2021-11-29T16:22:01.635Z,1638202921.635 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:22:02.019Z,1638202922.019 [DAT](INFO): setting remote address to 1
2021-11-29T16:22:02.427Z,1638202922.427 [DAT](INFO): DAT read: user:6>

2021-11-29T16:22:02.428Z,1638202922.428 [DAT](INFO): DAT read: RemoteAddr      | 1           

2021-11-29T16:22:02.429Z,1638202922.429 [DAT](INFO): set remote address to 1
2021-11-29T16:22:02.430Z,1638202922.430 [DAT](INFO): entering online mode
2021-11-29T16:22:02.831Z,1638202922.831 [DAT](INFO): DAT read: user:7>

2021-11-29T16:22:02.832Z,1638202922.832 [DAT](INFO): DAT read: 

2021-11-29T16:22:02.833Z,1638202922.833 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T16:22:02.833Z,1638202922.833 [DAT](INFO): commRate: 1200
2021-11-29T16:22:02.833Z,1638202922.833 [DAT](INFO): online mode acknowledged
2021-11-29T16:22:02.834Z,1638202922.834 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:22:06.474Z,1638202926.474 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:21:27.3904

2021-11-29T16:22:06.474Z,1638202926.474 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:22:16.537Z,1638202936.537 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:22:16.538Z,1638202936.538 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:22:16.940Z,1638202936.940 [DAT](INFO): #Outgoing data=1
2021-11-29T16:22:16.940Z,1638202936.940 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:22:17.352Z,1638202937.352 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:22:20.982Z,1638202940.982 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:21:41.8901

2021-11-29T16:22:20.983Z,1638202940.983 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:22:31.081Z,1638202951.081 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:22:31.081Z,1638202951.081 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:22:31.488Z,1638202951.488 [DAT](INFO): #Outgoing data=2
2021-11-29T16:22:31.488Z,1638202951.488 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:22:31.893Z,1638202951.893 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:22:35.529Z,1638202955.529 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:21:56.4399

2021-11-29T16:22:35.530Z,1638202955.530 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:22:45.686Z,1638202965.686 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:22:45.686Z,1638202965.686 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:22:46.074Z,1638202966.074 [DAT](INFO): #Outgoing data=3
2021-11-29T16:22:46.075Z,1638202966.075 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:22:46.446Z,1638202966.446 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:22:50.080Z,1638202970.080 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:22:10.9911

2021-11-29T16:22:50.080Z,1638202970.080 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:23:00.195Z,1638202980.195 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:23:00.195Z,1638202980.195 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:23:00.604Z,1638202980.604 [DAT](INFO): Sent 151 bytes from file Logs/20211129T161830/Courier0000.lzma.parts
2021-11-29T16:23:00.604Z,1638202980.604 [DAT](INFO): Packets left to send: 0
2021-11-29T16:23:00.607Z,1638202980.607 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:23:00.986Z,1638202980.986 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:23:00.995Z,1638202980.995 [Startup:StartupSatComms:B](INFO): Timed out from 2021-11-29T16:22:00.8Z
2021-11-29T16:23:00.995Z,1638202980.995 [Startup:StartupSatComms:B] Stopped
2021-11-29T16:23:00.995Z,1638202980.995 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2021-11-29T16:23:00.995Z,1638202980.995 [Startup:StartupSatComms] Stopped
2021-11-29T16:23:00.996Z,1638202980.996 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2021-11-29T16:23:00.996Z,1638202980.996 [Startup](INFO): Completed Startup
2021-11-29T16:23:00.997Z,1638202980.997 [MissionManager](INFO): Startup is completed.
2021-11-29T16:23:00.997Z,1638202980.997 [MissionManager](INFO): Uninitializing Mission Startup
2021-11-29T16:23:00.997Z,1638202980.997 [Startup] Stopped
2021-11-29T16:23:00.997Z,1638202980.997 [Startup](DEBUG): Aggregate::uninitialize Startup
2021-11-29T16:23:00.997Z,1638202980.997 [Startup:A.GoToSurface] Stopped
2021-11-29T16:23:00.997Z,1638202980.997 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-11-29T16:23:01.378Z,1638202981.378 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:23:01.441Z,1638202981.441 [MissionManager](IMPORTANT): Started mission Default
2021-11-29T16:23:01.447Z,1638202981.447 [Default] Running Loop=1
2021-11-29T16:23:01.448Z,1638202981.448 [Default](DEBUG): Aggregate::initialize Default
2021-11-29T16:23:01.448Z,1638202981.448 [Default:B.GoToSurface] Running Loop=1
2021-11-29T16:23:01.449Z,1638202981.449 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-11-29T16:23:01.454Z,1638202981.454 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-11-29T16:23:01.456Z,1638202981.456 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-11-29T16:23:01.458Z,1638202981.458 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-11-29T16:23:01.464Z,1638202981.464 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-11-29T16:23:01.466Z,1638202981.466 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-11-29T16:23:01.472Z,1638202981.472 [Default:A.Wait] Running Loop=1
2021-11-29T16:23:01.472Z,1638202981.472 [Default:A.Wait](DEBUG): Initialize Wait Component.
2021-11-29T16:23:05.032Z,1638202985.032 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:22:25.9395

2021-11-29T16:23:05.032Z,1638202985.032 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:23:14.722Z,1638202994.722 [Default:A.Wait](INFO): Done Waiting.
2021-11-29T16:23:14.722Z,1638202994.722 [Default:A.Wait] Stopped
2021-11-29T16:23:14.722Z,1638202994.722 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T16:23:15.131Z,1638202995.131 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:23:15.131Z,1638202995.131 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:23:15.145Z,1638202995.145 [Default:CheckIn] Running Loop=1
2021-11-29T16:23:15.146Z,1638202995.146 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T16:23:15.146Z,1638202995.146 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T16:23:15.535Z,1638202995.535 [DAT](DEBUG): In sendingVerified, sbd done so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:23:15.549Z,1638202995.549 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2021-11-29T16:23:15.939Z,1638202995.939 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:23:16.340Z,1638202996.340 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:23:18.006Z,1638202998.006 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:23:19.962Z,1638202999.962 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:22:40.8892

2021-11-29T16:23:19.962Z,1638202999.962 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:23:28.919Z,1638203008.919 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:23:30.069Z,1638203010.069 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:23:30.069Z,1638203010.069 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:23:30.468Z,1638203010.468 [DAT](DEBUG): In sendingVerified, sbd done so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:23:30.891Z,1638203010.891 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:23:31.296Z,1638203011.296 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:23:34.914Z,1638203014.914 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:22:55.8390

2021-11-29T16:23:34.914Z,1638203014.914 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:23:39.824Z,1638203019.824 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:23:45.013Z,1638203025.013 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:23:45.013Z,1638203025.013 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:23:45.417Z,1638203025.417 [DAT](DEBUG): In sendingVerified, sbd done so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:23:50.731Z,1638203030.731 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:23:52.398Z,1638203032.398 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:02.045Z,1638203042.045 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:03.256Z,1638203043.256 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:12.952Z,1638203052.952 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:14.163Z,1638203054.163 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:23.866Z,1638203063.866 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:24.616Z,1638203064.616 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2021-11-29T16:24:25.079Z,1638203065.079 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:34.360Z,1638203074.360 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:35.573Z,1638203075.573 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:42.819Z,1638203082.819 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2021-11-29T16:24:42.819Z,1638203082.819 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:24:42.830Z,1638203082.830 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:24:43.236Z,1638203083.236 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:24:43.236Z,1638203083.236 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2021-11-29T16:24:45.272Z,1638203085.272 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:46.482Z,1638203086.482 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:56.179Z,1638203096.179 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:24:57.391Z,1638203097.391 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:07.493Z,1638203107.493 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:08.310Z,1638203108.310 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:18.405Z,1638203118.405 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:19.616Z,1638203119.616 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:29.309Z,1638203129.309 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:30.520Z,1638203130.520 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:40.217Z,1638203140.217 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:41.428Z,1638203141.428 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:51.124Z,1638203151.124 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:25:52.337Z,1638203152.337 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:02.063Z,1638203162.063 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:03.243Z,1638203163.243 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:09.615Z,1638203169.615 [CommandExec](IMPORTANT): got command burn on
2021-11-29T16:26:09.615Z,1638203169.615 [CommandExec](IMPORTANT): Activating dropweight wire
2021-11-29T16:26:12.945Z,1638203172.945 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:14.156Z,1638203174.156 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:23.849Z,1638203183.849 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:25.060Z,1638203185.060 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:34.756Z,1638203194.756 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:34.761Z,1638203194.761 [DAT](INFO): DAT read: Lowpower

2021-11-29T16:26:34.761Z,1638203194.761 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T16:26:36.373Z,1638203196.373 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:45.665Z,1638203205.665 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:47.280Z,1638203207.280 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:56.571Z,1638203216.571 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:26:58.188Z,1638203218.188 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:02.631Z,1638203222.631 [CommandExec](IMPORTANT): got command burn off
2021-11-29T16:27:02.631Z,1638203222.631 [CommandExec](IMPORTANT): Deactivating dropweight wire
2021-11-29T16:27:07.485Z,1638203227.485 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:09.099Z,1638203229.099 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:18.388Z,1638203238.388 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:20.004Z,1638203240.004 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:29.297Z,1638203249.297 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:31.321Z,1638203251.321 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:40.609Z,1638203260.609 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:42.224Z,1638203262.224 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:43.804Z,1638203263.804 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2021-11-29T16:27:43.804Z,1638203263.804 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:27:43.815Z,1638203263.815 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:27:44.212Z,1638203264.212 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:27:44.212Z,1638203264.212 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2021-11-29T16:27:51.919Z,1638203271.919 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-11-29T16:27:52.739Z,1638203272.739 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2021-11-29T16:28:15.308Z,1638203295.308 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-11-29T16:23:15.1Z
2021-11-29T16:28:15.308Z,1638203295.308 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T16:28:15.308Z,1638203295.308 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T16:28:15.701Z,1638203295.701 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2021-11-29T16:28:16.153Z,1638203296.153 [DAT](INFO): #Outgoing data=1
2021-11-29T16:28:16.153Z,1638203296.153 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:28:16.518Z,1638203296.518 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:28:16.918Z,1638203296.918 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T16:28:16.919Z,1638203296.919 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T16:28:16.919Z,1638203296.919 [DAT](INFO): commRate: 1200
2021-11-29T16:28:19.750Z,1638203299.750 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:27:43.2795

2021-11-29T16:28:19.750Z,1638203299.750 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:28:29.836Z,1638203309.836 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:28:29.836Z,1638203309.836 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:28:30.233Z,1638203310.233 [DAT](INFO): Sent 38 bytes from file Logs/20211129T161830/Courier0004.lzma.parts
2021-11-29T16:28:30.233Z,1638203310.233 [DAT](INFO): Packets left to send: 0
2021-11-29T16:28:30.236Z,1638203310.236 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:28:30.649Z,1638203310.649 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T16:28:30.649Z,1638203310.649 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T16:28:30.649Z,1638203310.649 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T16:28:45.186Z,1638203325.186 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 
2021-11-29T16:28:45.262Z,1638203325.262 [NAL9602](ERROR): received: 
+CSQ:0

OK
2021-11-29T16:29:22.752Z,1638203362.752 [NAL9602](FAULT): GPS failed to acquire within timeout.
2021-11-29T16:29:22.752Z,1638203362.752 [NAL9602] Data Fault, FailCount= 1
2021-11-29T16:29:22.752Z,1638203362.752 [NAL9602](ERROR): Data Fault
2021-11-29T16:29:22.820Z,1638203362.820 [CBIT](ERROR): Data Fault in component: NAL9602
2021-11-29T16:29:23.156Z,1638203363.156 [NAL9602](INFO): Powering down
2021-11-29T16:29:24.002Z,1638203364.002 [CBIT](INFO): Clearing failed state for component NAL9602
2021-11-29T16:29:24.003Z,1638203364.003 [NAL9602] No Fault, FailCount= 1
2021-11-29T16:29:53.474Z,1638203393.474 [NAL9602](INFO): Powering up NAL9602
2021-11-29T16:30:04.384Z,1638203404.384 [NAL9602](INFO): NAL9602 initialized
2021-11-29T16:30:44.784Z,1638203444.784 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2021-11-29T16:30:44.784Z,1638203444.784 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:30:44.795Z,1638203444.795 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:30:45.204Z,1638203445.204 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:30:45.204Z,1638203445.204 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2021-11-29T16:31:19.931Z,1638203479.931 [DAT](INFO): DAT read: Lowpower

2021-11-29T16:31:19.932Z,1638203479.932 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T16:33:31.234Z,1638203611.234 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T16:33:31.234Z,1638203611.234 [Default:CheckIn:C.Wait] Stopped
2021-11-29T16:33:31.235Z,1638203611.235 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T16:33:31.235Z,1638203611.235 [Default:CheckIn:D] Running Loop=1
2021-11-29T16:33:31.710Z,1638203611.710 [Default:CheckIn:D] Stopped
2021-11-29T16:33:31.710Z,1638203611.710 [Default:CheckIn:E] Running Loop=1
2021-11-29T16:33:32.068Z,1638203612.068 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.504462 min 
2021-11-29T16:33:32.068Z,1638203612.068 [Default:CheckIn:E] Stopped
2021-11-29T16:33:32.068Z,1638203612.068 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T16:33:32.068Z,1638203612.068 [Default:CheckIn] Stopped
2021-11-29T16:33:32.069Z,1638203612.069 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T16:33:32.069Z,1638203612.069 [Default:CheckIn](INFO): Running loop #2
2021-11-29T16:33:32.069Z,1638203612.069 [Default:CheckIn] Running Loop=2
2021-11-29T16:33:32.069Z,1638203612.069 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T16:33:32.069Z,1638203612.069 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T16:33:45.809Z,1638203625.809 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2021-11-29T16:33:45.810Z,1638203625.810 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:33:45.821Z,1638203625.821 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:33:46.234Z,1638203626.234 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:33:46.234Z,1638203626.234 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2021-11-29T16:35:19.507Z,1638203719.507 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2021-11-29T16:35:19.515Z,1638203719.515 [BPC1](INFO): Received data from all battery sticks.
2021-11-29T16:35:40.675Z,1638203740.675 [CommandExec](IMPORTANT): got command failComponent
2021-11-29T16:35:40.675Z,1638203740.675 [CommandExec](IMPORTANT): Failed components:
2021-11-29T16:35:40.676Z,1638203740.676 [CommandExec](IMPORTANT): No failed Components.
2021-11-29T16:36:46.811Z,1638203806.811 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2021-11-29T16:36:46.811Z,1638203806.811 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:36:46.822Z,1638203806.822 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:36:47.226Z,1638203807.226 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:36:47.226Z,1638203807.226 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2021-11-29T16:38:32.210Z,1638203912.210 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-11-29T16:33:32.1Z
2021-11-29T16:38:32.210Z,1638203912.210 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T16:38:32.210Z,1638203912.210 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T16:38:33.027Z,1638203913.027 [DAT](INFO): #Outgoing data=1
2021-11-29T16:38:33.027Z,1638203913.027 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:38:33.428Z,1638203913.428 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:38:33.827Z,1638203913.827 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T16:38:33.829Z,1638203913.829 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T16:38:33.829Z,1638203913.829 [DAT](INFO): commRate: 1200
2021-11-29T16:38:37.050Z,1638203917.050 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:38:00.4295

2021-11-29T16:38:37.050Z,1638203917.050 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:38:47.145Z,1638203927.145 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:38:47.145Z,1638203927.145 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:38:47.576Z,1638203927.576 [DAT](INFO): Sent 168 bytes from file Logs/20211129T161830/Courier0007.lzma.parts
2021-11-29T16:38:47.576Z,1638203927.576 [DAT](INFO): Packets left to send: 0
2021-11-29T16:38:47.578Z,1638203927.578 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:38:47.964Z,1638203927.964 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T16:38:47.964Z,1638203927.964 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T16:38:47.964Z,1638203927.964 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T16:39:47.772Z,1638203987.772 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2021-11-29T16:39:47.772Z,1638203987.772 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:39:47.784Z,1638203987.784 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:39:48.174Z,1638203988.174 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:39:48.174Z,1638203988.174 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2021-11-29T16:40:05.528Z,1638204005.528 [NAL9602](FAULT): GPS failed to acquire within timeout.
2021-11-29T16:40:05.528Z,1638204005.528 [NAL9602] Data Fault, FailCount= 2
2021-11-29T16:40:05.528Z,1638204005.528 [NAL9602](ERROR): Data Fault
2021-11-29T16:40:05.593Z,1638204005.593 [CBIT](ERROR): Data Fault in component: NAL9602
2021-11-29T16:40:05.932Z,1638204005.932 [NAL9602](INFO): Powering down
2021-11-29T16:40:06.769Z,1638204006.769 [CBIT](INFO): Clearing failed state for component NAL9602
2021-11-29T16:40:06.770Z,1638204006.770 [NAL9602] No Fault, FailCount= 2
2021-11-29T16:40:36.223Z,1638204036.223 [NAL9602](INFO): Powering up NAL9602
2021-11-29T16:40:47.143Z,1638204047.143 [NAL9602](INFO): NAL9602 initialized
2021-11-29T16:41:36.835Z,1638204096.835 [DAT](INFO): DAT read: Lowpower

2021-11-29T16:41:36.836Z,1638204096.836 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T16:42:48.771Z,1638204168.771 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2021-11-29T16:42:48.771Z,1638204168.771 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:42:48.790Z,1638204168.790 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:42:49.204Z,1638204169.204 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:42:49.205Z,1638204169.205 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2021-11-29T16:43:48.576Z,1638204228.576 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T16:43:48.576Z,1638204228.576 [Default:CheckIn:C.Wait] Stopped
2021-11-29T16:43:48.577Z,1638204228.577 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T16:43:48.577Z,1638204228.577 [Default:CheckIn:D] Running Loop=1
2021-11-29T16:43:48.983Z,1638204228.983 [Default:CheckIn:D] Stopped
2021-11-29T16:43:48.983Z,1638204228.983 [Default:CheckIn:E] Running Loop=1
2021-11-29T16:43:49.371Z,1638204229.371 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.792344 min 
2021-11-29T16:43:49.371Z,1638204229.371 [Default:CheckIn:E] Stopped
2021-11-29T16:43:49.371Z,1638204229.371 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T16:43:49.371Z,1638204229.371 [Default:CheckIn] Stopped
2021-11-29T16:43:49.371Z,1638204229.371 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T16:43:49.372Z,1638204229.372 [Default:CheckIn](INFO): Running loop #3
2021-11-29T16:43:49.372Z,1638204229.372 [Default:CheckIn] Running Loop=3
2021-11-29T16:43:49.372Z,1638204229.372 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T16:43:49.372Z,1638204229.372 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T16:45:49.764Z,1638204349.764 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2021-11-29T16:45:49.764Z,1638204349.764 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:45:49.775Z,1638204349.775 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:45:50.156Z,1638204350.156 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:45:50.156Z,1638204350.156 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2021-11-29T16:48:49.524Z,1638204529.524 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-11-29T16:43:49.4Z
2021-11-29T16:48:49.524Z,1638204529.524 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T16:48:49.524Z,1638204529.524 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T16:48:50.329Z,1638204530.329 [DAT](INFO): #Outgoing data=1
2021-11-29T16:48:50.329Z,1638204530.329 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:48:50.732Z,1638204530.732 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:48:50.804Z,1638204530.804 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2021-11-29T16:48:50.804Z,1638204530.804 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2021-11-29T16:48:50.817Z,1638204530.817 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2021-11-29T16:48:51.160Z,1638204531.160 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T16:48:51.161Z,1638204531.161 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T16:48:51.161Z,1638204531.161 [DAT](INFO): commRate: 1200
2021-11-29T16:48:51.190Z,1638204531.190 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2021-11-29T16:48:51.191Z,1638204531.191 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2021-11-29T16:48:54.366Z,1638204534.366 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:48:17.3307

2021-11-29T16:48:54.366Z,1638204534.366 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:49:04.469Z,1638204544.469 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:49:04.469Z,1638204544.469 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:49:04.884Z,1638204544.884 [DAT](INFO): Sent 39 bytes from file Logs/20211129T161830/Courier0010.lzma.parts
2021-11-29T16:49:04.885Z,1638204544.885 [DAT](INFO): Packets left to send: 0
2021-11-29T16:49:04.887Z,1638204544.887 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:49:05.315Z,1638204545.315 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T16:49:05.315Z,1638204545.315 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T16:49:05.315Z,1638204545.315 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T16:49:09.257Z,1638204549.257 [CommandExec](IMPORTANT): got command run ./Missions/Insert/Science.xml
2021-11-29T16:49:09.257Z,1638204549.257 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2021-11-29T16:49:09.572Z,1638204549.572 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2021-11-29T16:49:09.576Z,1638204549.576 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min
2021-11-29T16:49:09.579Z,1638204549.579 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2021-11-29T16:49:09.582Z,1638204549.582 [MissionManager](INFO): DefineArg Science.HighestSaltPeakReportActive = 0 bool
2021-11-29T16:49:09.585Z,1638204549.585 [MissionManager](INFO): DefineArg Science.HighestOilPeakReportActive = 0 bool
2021-11-29T16:49:09.589Z,1638204549.589 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2021-11-29T16:49:09.592Z,1638204549.592 [MissionManager](INFO): DefineArg Science.DetectTrough = 0 bool
2021-11-29T16:49:09.596Z,1638204549.596 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2021-11-29T16:49:09.599Z,1638204549.599 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2021-11-29T16:49:09.603Z,1638204549.603 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2021-11-29T16:49:09.606Z,1638204549.606 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2021-11-29T16:49:09.609Z,1638204549.609 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2021-11-29T16:49:09.612Z,1638204549.612 [MissionManager](INFO): DefineArg Science.PeakDetectFDOMActive = 0 bool
2021-11-29T16:49:09.615Z,1638204549.615 [MissionManager](INFO): DefineArg Science.PeakDetectSalinityActive = 0 bool
2021-11-29T16:49:09.659Z,1638204549.659 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2021-11-29T16:49:09.673Z,1638204549.673 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 bool
2021-11-29T16:49:09.678Z,1638204549.678 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 0.000000 bool
2021-11-29T16:49:09.690Z,1638204549.690 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 1.000000 bool
2021-11-29T16:49:09.734Z,1638204549.734 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2021-11-29T16:49:09.757Z,1638204549.757 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2021-11-29T16:49:09.761Z,1638204549.761 [MissionManager](INFO): DefineArg Science.EnabledWetLabsUBAT = 0.000000 bool
2021-11-29T16:49:09.811Z,1638204549.811 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2021-11-29T16:49:09.814Z,1638204549.814 [MissionManager](INFO): DefineArg Science.MedianFilterLen = 5.000000 count
2021-11-29T16:49:09.818Z,1638204549.818 [MissionManager](INFO): DefineArg Science.PeakShallowBound = nan m
2021-11-29T16:49:09.821Z,1638204549.821 [MissionManager](INFO): DefineArg Science.PeakDeepBound = nan m
2021-11-29T16:49:09.842Z,1638204549.842 [MissionManager](INFO): DefineArg Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2021-11-29T16:49:09.846Z,1638204549.846 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2021-11-29T16:49:09.849Z,1638204549.849 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2021-11-29T16:49:09.886Z,1638204549.886 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2021-11-29T16:49:09.890Z,1638204549.890 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2021-11-29T16:49:09.893Z,1638204549.893 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2021-11-29T16:49:09.905Z,1638204549.905 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2021-11-29T16:49:09.909Z,1638204549.909 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2021-11-29T16:49:09.913Z,1638204549.913 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2021-11-29T16:49:09.943Z,1638204549.943 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2021-11-29T16:49:09.947Z,1638204549.947 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2021-11-29T16:49:09.962Z,1638204549.962 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2021-11-29T16:49:09.966Z,1638204549.966 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2021-11-29T16:49:09.969Z,1638204549.969 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2021-11-29T16:49:09.973Z,1638204549.973 [MissionManager](INFO): DefineOutput Science.PeakFDOM = 0.000000 ppb
2021-11-29T16:49:10.000Z,1638204550.000 [MissionManager](INFO): DefineOutput Science.PeakFDOMDepth = 0.000000 m
2021-11-29T16:49:10.004Z,1638204550.004 [MissionManager](INFO): DefineOutput Science.PeakFDOMTemperature = nan degC
2021-11-29T16:49:10.007Z,1638204550.007 [MissionManager](INFO): DefineOutput Science.PeakFDOMLatitude = nan arcdeg
2021-11-29T16:49:10.031Z,1638204550.031 [MissionManager](INFO): DefineOutput Science.PeakFDOMLongitude = nan arcdeg
2021-11-29T16:49:10.035Z,1638204550.035 [MissionManager](INFO): DefineOutput Science.PatchFDOMDistance = nan m
2021-11-29T16:49:10.038Z,1638204550.038 [MissionManager](INFO): DefineOutput Science.PeakSalt = 0.000000 psu
2021-11-29T16:49:10.042Z,1638204550.042 [MissionManager](INFO): DefineOutput Science.PeakSaltDepth = 0.000000 m
2021-11-29T16:49:10.066Z,1638204550.066 [MissionManager](INFO): DefineOutput Science.PeakSaltTemperature = 0.000000 degC
2021-11-29T16:49:10.069Z,1638204550.069 [MissionManager](INFO): DefineOutput Science.PeakSaltLatitude = nan arcdeg
2021-11-29T16:49:10.073Z,1638204550.073 [MissionManager](INFO): DefineOutput Science.PeakSaltLongitude = nan arcdeg
2021-11-29T16:49:10.097Z,1638204550.097 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 ug/l
2021-11-29T16:49:10.101Z,1638204550.101 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2021-11-29T16:49:10.105Z,1638204550.105 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2021-11-29T16:49:10.160Z,1638204550.160 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2021-11-29T16:49:10.164Z,1638204550.164 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2021-11-29T16:49:10.167Z,1638204550.167 [MissionManager](INFO): DefineOutput Science.PatchSalt = 0.000000 psu
2021-11-29T16:49:10.180Z,1638204550.180 [MissionManager](INFO): DefineOutput Science.PatchSaltDepth = 0.000000 m
2021-11-29T16:49:10.185Z,1638204550.185 [MissionManager](INFO): DefineOutput Science.PatchSaltLatitude = nan arcdeg
2021-11-29T16:49:10.197Z,1638204550.197 [MissionManager](INFO): DefineOutput Science.PatchSaltLongitude = nan arcdeg
2021-11-29T16:49:10.201Z,1638204550.201 [MissionManager](INFO): DefineOutput Science.PatchSaltDistance = nan m
2021-11-29T16:49:10.212Z,1638204550.212 [MissionManager](INFO): DefineOutput Science.PatchOil = 0.000000 psu
2021-11-29T16:49:10.217Z,1638204550.217 [MissionManager](INFO): DefineOutput Science.PatchOilDepth = 0.000000 m
2021-11-29T16:49:10.229Z,1638204550.229 [MissionManager](INFO): DefineOutput Science.PatchOilLatitude = nan arcdeg
2021-11-29T16:49:10.241Z,1638204550.241 [MissionManager](INFO): DefineOutput Science.PatchOilLongitude = nan arcdeg
2021-11-29T16:49:10.255Z,1638204550.255 [MissionManager](INFO): DefineOutput Science.PatchOilDistance = nan m
2021-11-29T16:49:10.328Z,1638204550.328 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-11-29T16:49:10.365Z,1638204550.365 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2021-11-29T16:49:10.407Z,1638204550.407 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-11-29T16:49:10.426Z,1638204550.426 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-11-29T16:49:10.468Z,1638204550.468 [Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2021-11-29T16:49:10.506Z,1638204550.506 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-11-29T16:49:10.589Z,1638204550.589 [Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2021-11-29T16:49:10.618Z,1638204550.618 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2021-11-29T16:49:10.722Z,1638204550.722 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Aggregate xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
           xmlns="Tethys"
           xmlns:Units="Tethys/Units"
           xmlns:Estimation="Tethys/Estimation"
           xmlns:Science="Tethys/Science"
           xmlns:Universal="Tethys/Universal"
           xmlns:Trigger="Tethys/Trigger"
           xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                               Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                               Tethys/Estimation http://okeanids.mbari.org/tethys/Xml/Estimation.xsd
                               Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                               Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd
                               Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.xsd"
       Id="Science">

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

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

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

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

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

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

    <DefineArg Name="DetectTrough"><Description>
        Whether to track a trough. If false, track peak; if true, track trough.
        Default is false.
    </Description><False/></DefineArg>

<!--debug    
    </Description><True/></DefineArg>
-->

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

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

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

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

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

    <DefineArg Name="PeakDetectFDOMActive"><Description>
        Turns on peak detection of
        concentration_of_colored_dissolved_organic_matter_in_sea_water from FDOM
        sensor.
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectSalinityActive"><Description>
        Turns on peak detection of salinity.
    </Description><False/></DefineArg>

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

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

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

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

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

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

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

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

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

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

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

    <DefineArg Name="DepChangeThreshForAttitudeFlip"><Description>
        Depth change threshold for determining vehicle attitude flip.
    </Description><Units:meter/><Value>2.0</Value></DefineArg>

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

    <DefineOutput Name="PeakFDOMTemperature"><Units:celsius/><Value>NaN</Value></DefineOutput>

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

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

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

    <DefineOutput Name="PeakSalt"><Units:psu/><Value>0</Value></DefineOutput>

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

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

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

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

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

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

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

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

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

    <DefineOutput Name="PatchSalt"><Units:psu/><Value>0</Value></DefineOutput>

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

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

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

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

    <DefineOutput Name="PatchOil"><Units:psu/><Value>0</Value></DefineOutput>

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

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

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

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

    <Parallel/>

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

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

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledSeabird"/>
        </While>
        <Science:CTD_Seabird.sea_water_temperature/>
        <Science:CTD_Seabird.sea_water_salinity/>
    </ReadData>

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

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

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

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

    <Aggregate Id="OceanCurrent">

        <Estimation:CurrentEstimator>
            <Parallel/>
        </Estimation:CurrentEstimator>

    </Aggregate>

    <Aggregate Id="PeakDetectChl">

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

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

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

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

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

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

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

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

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

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

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

    </Aggregate>

    <Aggregate Id="PeakDetectOil">

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

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

<!--debug
        <Syslog Severity="Important">PeakOil, PeakOilDepth, PeakOilTemperature, PeakOilLatitude, PeakOilLongitude = <Arg Name="PeakOil"/><Units:kilogram_per_cubic_meter/>, <Arg Name="PeakOilDepth"/><Units:meter/>, <Arg Name="PeakOilTemperature"/><Units:celsius/>, <Arg Name="PeakOilLatitude"/><Units:degree/>, <Arg Name="PeakOilLongitude"/><Units:degree/></Syslog>
-->

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

    </Aggregate>

    <Aggregate Id="HighestOilPeakReport">

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

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakOil"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakOilDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakOilLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakOilLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.offPeakFraction/><Arg Name="OffPeakFractionHorizontal"/></Setting>
            <OutputArg Name="PatchOil"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchOilDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchOilLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchOilLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchOilDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

    <Aggregate Id="PeakDetectFDOM">

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

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

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

    </Aggregate>

    <Aggregate Id="PeakDetectSalinity">

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

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:sea_water_salinity/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.medianFilterLength/><Arg Name="MedianFilterLen"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.depthChangeThresh/><Arg Name="DepChangeThreshForAttitudeFlip"/></Setting>
            <OutputArg Name="PeakSalt"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakSaltDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakSaltTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakSaltLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakSaltLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

<!--debug
        <Syslog Severity="Important">PeakSalt, PeakSaltDepth, PeakSaltTemperature, PeakSaltLatitude, PeakSaltLongitude = <Arg Name="PeakSalt"/><Units:psu/>, <Arg Name="PeakSaltDepth"/><Units:meter/>, <Arg Name="PeakSaltTemperature"/><Units:celsius/>, <Arg Name="PeakSaltLatitude"/><Units:degree/>, <Arg Name="PeakSaltLongitude"/><Units:degree/></Syslog>
-->

        <SendData Service="Express"><Arg Name="PeakSalt"/><Arg Name="PeakSaltDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HighestSaltPeakReport">

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

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakSalt"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakSaltDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakSaltLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakSaltLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.offPeakFraction/><Arg Name="OffPeakFractionHorizontal"/></Setting>
            <OutputArg Name="PatchSalt"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchSaltDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchSaltLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchSaltLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchSaltDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

</Aggregate>


2021-11-29T16:49:10.729Z,1638204550.729 [CommandExec](IMPORTANT): Running ./Missions/Insert/Science.xml
2021-11-29T16:49:10.949Z,1638204550.949 [Default] Stopped
2021-11-29T16:49:10.949Z,1638204550.949 [Default](DEBUG): Aggregate::uninitialize Default
2021-11-29T16:49:10.949Z,1638204550.949 [Default:B.GoToSurface] Stopped
2021-11-29T16:49:10.949Z,1638204550.949 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-11-29T16:49:10.949Z,1638204550.949 [Default:CheckIn] Stopped
2021-11-29T16:49:10.950Z,1638204550.950 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T16:49:10.950Z,1638204550.950 [Default:CheckIn:C.Wait] Stopped
2021-11-29T16:49:10.950Z,1638204550.950 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T16:49:10.954Z,1638204550.954 [MissionManager](IMPORTANT): Started mission Science
2021-11-29T16:49:10.954Z,1638204550.954 [Science] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science](DEBUG): Aggregate::initialize Science
2021-11-29T16:49:10.955Z,1638204550.955 [Science:A] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:B] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:C] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:D] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:E] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:F] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:Read_Oil] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:PeakDetectChl] Running Loop=1
2021-11-29T16:49:10.955Z,1638204550.955 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2021-11-29T16:49:10.956Z,1638204550.956 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2021-11-29T16:49:10.956Z,1638204550.956 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2021-11-29T16:49:10.958Z,1638204550.958 [Science:HighestChlPeakReport] Running Loop=1
2021-11-29T16:49:10.958Z,1638204550.958 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2021-11-29T16:49:10.962Z,1638204550.962 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2021-11-29T16:49:10.962Z,1638204550.962 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2021-11-29T16:49:10.963Z,1638204550.963 [Science:PeakDetectNO3] Running Loop=1
2021-11-29T16:49:10.963Z,1638204550.963 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2021-11-29T16:49:10.963Z,1638204550.963 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2021-11-29T16:49:10.963Z,1638204550.963 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2021-11-29T16:49:10.965Z,1638204550.965 [Science:PeakDetectOil] Running Loop=1
2021-11-29T16:49:10.965Z,1638204550.965 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2021-11-29T16:49:10.965Z,1638204550.965 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2021-11-29T16:49:10.966Z,1638204550.966 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2021-11-29T16:49:10.983Z,1638204550.983 [Science:HighestOilPeakReport] Running Loop=1
2021-11-29T16:49:10.984Z,1638204550.984 [Science:HighestOilPeakReport](DEBUG): Aggregate::initialize Science:HighestOilPeakReport
2021-11-29T16:49:10.984Z,1638204550.984 [Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2021-11-29T16:49:10.984Z,1638204550.984 [Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2021-11-29T16:49:10.984Z,1638204550.984 [Science:PeakDetectFDOM] Running Loop=1
2021-11-29T16:49:10.984Z,1638204550.984 [Science:PeakDetectFDOM](DEBUG): Aggregate::initialize Science:PeakDetectFDOM
2021-11-29T16:49:10.985Z,1638204550.985 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2021-11-29T16:49:10.985Z,1638204550.985 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2021-11-29T16:49:10.987Z,1638204550.987 [Science:PeakDetectSalinity] Running Loop=1
2021-11-29T16:49:10.987Z,1638204550.987 [Science:PeakDetectSalinity](DEBUG): Aggregate::initialize Science:PeakDetectSalinity
2021-11-29T16:49:10.987Z,1638204550.987 [Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1
2021-11-29T16:49:10.988Z,1638204550.988 [Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize.
2021-11-29T16:49:10.989Z,1638204550.989 [Science:HighestSaltPeakReport] Running Loop=1
2021-11-29T16:49:10.989Z,1638204550.989 [Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize Science:HighestSaltPeakReport
2021-11-29T16:49:10.989Z,1638204550.989 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2021-11-29T16:49:10.990Z,1638204550.990 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2021-11-29T16:49:10.994Z,1638204550.994 [Science:OceanCurrent] Running Loop=1
2021-11-29T16:49:10.994Z,1638204550.994 [Science:OceanCurrent](DEBUG): Aggregate::initialize Science:OceanCurrent
2021-11-29T16:49:10.995Z,1638204550.995 [Science:OceanCurrent:A.] Running Loop=1
2021-11-29T16:49:10.995Z,1638204550.995 [Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2021-11-29T16:49:10.996Z,1638204550.996 [Science:HighestSaltPeakReport] Stopped
2021-11-29T16:49:10.996Z,1638204550.996 [Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize Science:HighestSaltPeakReport
2021-11-29T16:49:10.996Z,1638204550.996 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2021-11-29T16:49:10.996Z,1638204550.996 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2021-11-29T16:49:10.996Z,1638204550.996 [Science:PeakDetectSalinity] Stopped
2021-11-29T16:49:10.996Z,1638204550.996 [Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize Science:PeakDetectSalinity
2021-11-29T16:49:10.996Z,1638204550.996 [Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped
2021-11-29T16:49:10.997Z,1638204550.997 [Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2021-11-29T16:49:10.997Z,1638204550.997 [Science:PeakDetectFDOM] Stopped
2021-11-29T16:49:10.997Z,1638204550.997 [Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize Science:PeakDetectFDOM
2021-11-29T16:49:10.997Z,1638204550.997 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2021-11-29T16:49:10.997Z,1638204550.997 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2021-11-29T16:49:10.997Z,1638204550.997 [Science:HighestOilPeakReport] Stopped
2021-11-29T16:49:10.997Z,1638204550.997 [Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize Science:HighestOilPeakReport
2021-11-29T16:49:10.997Z,1638204550.997 [Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2021-11-29T16:49:10.997Z,1638204550.997 [Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2021-11-29T16:49:10.997Z,1638204550.997 [Science:PeakDetectOil] Stopped
2021-11-29T16:49:10.998Z,1638204550.998 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2021-11-29T16:49:10.998Z,1638204550.998 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2021-11-29T16:49:10.998Z,1638204550.998 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2021-11-29T16:49:10.998Z,1638204550.998 [Science:PeakDetectNO3] Stopped
2021-11-29T16:49:10.998Z,1638204550.998 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2021-11-29T16:49:11.002Z,1638204551.002 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2021-11-29T16:49:11.002Z,1638204551.002 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2021-11-29T16:49:11.002Z,1638204551.002 [Science:HighestChlPeakReport] Stopped
2021-11-29T16:49:11.003Z,1638204551.003 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2021-11-29T16:49:11.003Z,1638204551.003 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2021-11-29T16:49:11.003Z,1638204551.003 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2021-11-29T16:49:11.003Z,1638204551.003 [Science:PeakDetectChl] Stopped
2021-11-29T16:49:11.003Z,1638204551.003 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2021-11-29T16:49:11.003Z,1638204551.003 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2021-11-29T16:49:11.003Z,1638204551.003 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2021-11-29T16:49:11.003Z,1638204551.003 [Science:OceanCurrent:A.] Running Loop=1
2021-11-29T16:49:11.003Z,1638204551.003 [Science:Read_Oil] Stopped
2021-11-29T16:49:11.004Z,1638204551.004 [Science:F] Stopped
2021-11-29T16:49:11.004Z,1638204551.004 [Science:E] Running Loop=1
2021-11-29T16:49:11.004Z,1638204551.004 [Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2021-11-29T16:49:11.004Z,1638204551.004 [Science:D] Stopped
2021-11-29T16:49:11.005Z,1638204551.005 [Science:C] Running Loop=1
2021-11-29T16:49:11.005Z,1638204551.005 [Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2021-11-29T16:49:11.006Z,1638204551.006 [Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2021-11-29T16:49:11.018Z,1638204551.018 [Science:B] Running Loop=1
2021-11-29T16:49:11.019Z,1638204551.019 [Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2021-11-29T16:49:11.020Z,1638204551.020 [Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2021-11-29T16:49:11.020Z,1638204551.020 [Science:A] Stopped
2021-11-29T16:49:11.072Z,1638204551.072 [WetLabsBB2FL](INFO): Powering up
2021-11-29T16:49:14.192Z,1638204554.192 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2021-11-29T16:49:59.814Z,1638204599.814 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164958.00,A,3648.15973,N,12147.28464,W,0.603,0.00,291121,,,A*7B
2021-11-29T16:49:59.818Z,1638204599.818 [NAL9602](INFO): GPS fix at 20211129T164958: (36.802662, -121.788077)
2021-11-29T16:50:20.303Z,1638204620.303 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 200.000000 cubic_centimeter
2021-11-29T16:50:20.307Z,1638204620.307 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2021-11-29T16:50:20.504Z,1638204620.504 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-11-29T16:50:32.179Z,1638204632.179 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T16:50:33.173Z,1638204633.173 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position
2021-11-29T16:50:33.471Z,1638204633.471 [Reporter](INFO): platform_buoyancy_position 864.076172 cc
2021-11-29T16:50:33.869Z,1638204633.869 [Reporter](INFO): platform_buoyancy_position 859.644226 cc
2021-11-29T16:50:34.264Z,1638204634.264 [Reporter](INFO): platform_buoyancy_position 853.332153 cc
2021-11-29T16:50:34.677Z,1638204634.677 [Reporter](INFO): platform_buoyancy_position 846.885742 cc
2021-11-29T16:50:35.087Z,1638204635.087 [Reporter](INFO): platform_buoyancy_position 842.319519 cc
2021-11-29T16:50:35.467Z,1638204635.467 [Reporter](INFO): platform_buoyancy_position 836.276062 cc
2021-11-29T16:50:35.884Z,1638204635.884 [Reporter](INFO): platform_buoyancy_position 831.844116 cc
2021-11-29T16:50:36.292Z,1638204636.292 [Reporter](INFO): platform_buoyancy_position 825.532043 cc
2021-11-29T16:50:36.677Z,1638204636.677 [Reporter](INFO): platform_buoyancy_position 821.100159 cc
2021-11-29T16:50:37.100Z,1638204637.100 [Reporter](INFO): platform_buoyancy_position 814.788025 cc
2021-11-29T16:50:37.511Z,1638204637.511 [Reporter](INFO): platform_buoyancy_position 810.356140 cc
2021-11-29T16:50:37.914Z,1638204637.914 [Reporter](INFO): platform_buoyancy_position 804.044067 cc
2021-11-29T16:50:38.305Z,1638204638.305 [Reporter](INFO): platform_buoyancy_position 799.746460 cc
2021-11-29T16:50:38.721Z,1638204638.721 [Reporter](INFO): platform_buoyancy_position 794.508728 cc
2021-11-29T16:50:39.126Z,1638204639.126 [Reporter](INFO): platform_buoyancy_position 789.002441 cc
2021-11-29T16:50:39.509Z,1638204639.509 [Reporter](INFO): platform_buoyancy_position 784.570557 cc
2021-11-29T16:50:39.929Z,1638204639.929 [Reporter](INFO): platform_buoyancy_position 778.124146 cc
2021-11-29T16:50:40.340Z,1638204640.340 [Reporter](INFO): platform_buoyancy_position 773.826538 cc
2021-11-29T16:50:40.717Z,1638204640.717 [Reporter](INFO): platform_buoyancy_position 767.514465 cc
2021-11-29T16:50:41.135Z,1638204641.135 [Reporter](INFO): platform_buoyancy_position 763.082520 cc
2021-11-29T16:50:41.555Z,1638204641.555 [Reporter](INFO): platform_buoyancy_position 756.636108 cc
2021-11-29T16:50:41.949Z,1638204641.949 [Reporter](INFO): platform_buoyancy_position 752.338562 cc
2021-11-29T16:50:42.345Z,1638204642.345 [Reporter](INFO): platform_buoyancy_position 746.026428 cc
2021-11-29T16:50:42.765Z,1638204642.765 [Reporter](INFO): platform_buoyancy_position 741.728821 cc
2021-11-29T16:50:43.165Z,1638204643.165 [Reporter](INFO): platform_buoyancy_position 735.416748 cc
2021-11-29T16:50:43.561Z,1638204643.561 [Reporter](INFO): platform_buoyancy_position 730.984863 cc
2021-11-29T16:50:43.961Z,1638204643.961 [Reporter](INFO): platform_buoyancy_position 726.284363 cc
2021-11-29T16:50:44.376Z,1638204644.376 [Reporter](INFO): platform_buoyancy_position 720.240845 cc
2021-11-29T16:50:44.784Z,1638204644.784 [Reporter](INFO): platform_buoyancy_position 714.600220 cc
2021-11-29T16:50:45.161Z,1638204645.161 [Reporter](INFO): platform_buoyancy_position 709.496826 cc
2021-11-29T16:50:45.575Z,1638204645.575 [Reporter](INFO): platform_buoyancy_position 704.930603 cc
2021-11-29T16:50:45.989Z,1638204645.989 [Reporter](INFO): platform_buoyancy_position 698.752808 cc
2021-11-29T16:50:46.394Z,1638204646.394 [Reporter](INFO): platform_buoyancy_position 694.320923 cc
2021-11-29T16:50:46.787Z,1638204646.787 [Reporter](INFO): platform_buoyancy_position 688.008850 cc
2021-11-29T16:50:47.213Z,1638204647.213 [Reporter](INFO): platform_buoyancy_position 683.576904 cc
2021-11-29T16:50:47.641Z,1638204647.641 [Reporter](INFO): platform_buoyancy_position 677.264832 cc
2021-11-29T16:50:48.029Z,1638204648.029 [Reporter](INFO): platform_buoyancy_position 672.832947 cc
2021-11-29T16:50:48.432Z,1638204648.432 [Reporter](INFO): platform_buoyancy_position 666.520813 cc
2021-11-29T16:50:48.825Z,1638204648.825 [Reporter](INFO): platform_buoyancy_position 662.088928 cc
2021-11-29T16:50:49.235Z,1638204649.235 [Reporter](INFO): platform_buoyancy_position 655.776855 cc
2021-11-29T16:50:49.633Z,1638204649.633 [Reporter](INFO): platform_buoyancy_position 651.344910 cc
2021-11-29T16:50:50.071Z,1638204650.071 [Reporter](INFO): platform_buoyancy_position 644.898499 cc
2021-11-29T16:50:50.425Z,1638204650.425 [Reporter](INFO): platform_buoyancy_position 640.735229 cc
2021-11-29T16:50:50.851Z,1638204650.851 [Reporter](INFO): platform_buoyancy_position 634.423157 cc
2021-11-29T16:50:51.243Z,1638204651.243 [Reporter](INFO): platform_buoyancy_position 629.991211 cc
2021-11-29T16:50:51.665Z,1638204651.665 [Reporter](INFO): platform_buoyancy_position 624.216309 cc
2021-11-29T16:50:52.086Z,1638204652.086 [Reporter](INFO): platform_buoyancy_position 619.112915 cc
2021-11-29T16:50:52.446Z,1638204652.446 [Reporter](INFO): platform_buoyancy_position 614.815308 cc
2021-11-29T16:50:52.941Z,1638204652.941 [Reporter](INFO): platform_buoyancy_position 608.100342 cc
2021-11-29T16:50:53.340Z,1638204653.340 [Reporter](INFO): platform_buoyancy_position 602.056824 cc
2021-11-29T16:50:53.674Z,1638204653.674 [Reporter](INFO): platform_buoyancy_position 597.759216 cc
2021-11-29T16:50:54.107Z,1638204654.107 [Reporter](INFO): platform_buoyancy_position 593.327332 cc
2021-11-29T16:50:54.466Z,1638204654.466 [Reporter](INFO): platform_buoyancy_position 589.029724 cc
2021-11-29T16:50:54.869Z,1638204654.869 [Reporter](INFO): platform_buoyancy_position 582.717651 cc
2021-11-29T16:50:55.320Z,1638204655.320 [Reporter](INFO): platform_buoyancy_position 576.136902 cc
2021-11-29T16:50:55.713Z,1638204655.713 [Reporter](INFO): platform_buoyancy_position 571.839294 cc
2021-11-29T16:50:56.145Z,1638204656.145 [Reporter](INFO): platform_buoyancy_position 565.527222 cc
2021-11-29T16:50:56.493Z,1638204656.493 [Reporter](INFO): platform_buoyancy_position 561.095337 cc
2021-11-29T16:50:56.922Z,1638204656.922 [Reporter](INFO): platform_buoyancy_position 554.783203 cc
2021-11-29T16:50:57.308Z,1638204657.308 [Reporter](INFO): platform_buoyancy_position 550.351318 cc
2021-11-29T16:50:57.712Z,1638204657.712 [Reporter](INFO): platform_buoyancy_position 544.173523 cc
2021-11-29T16:50:58.112Z,1638204658.112 [Reporter](INFO): platform_buoyancy_position 539.607300 cc
2021-11-29T16:50:58.505Z,1638204658.505 [Reporter](INFO): platform_buoyancy_position 535.309692 cc
2021-11-29T16:50:58.917Z,1638204658.917 [Reporter](INFO): platform_buoyancy_position 528.863342 cc
2021-11-29T16:50:59.322Z,1638204659.322 [Reporter](INFO): platform_buoyancy_position 522.685547 cc
2021-11-29T16:50:59.717Z,1638204659.717 [Reporter](INFO): platform_buoyancy_position 518.119324 cc
2021-11-29T16:51:00.125Z,1638204660.125 [Reporter](INFO): platform_buoyancy_position 513.821716 cc
2021-11-29T16:51:00.537Z,1638204660.537 [Reporter](INFO): platform_buoyancy_position 507.509674 cc
2021-11-29T16:51:00.917Z,1638204660.917 [Reporter](INFO): platform_buoyancy_position 503.077759 cc
2021-11-29T16:51:01.329Z,1638204661.329 [Reporter](INFO): platform_buoyancy_position 496.765656 cc
2021-11-29T16:51:01.753Z,1638204661.753 [Reporter](INFO): platform_buoyancy_position 492.199432 cc
2021-11-29T16:51:02.161Z,1638204662.161 [Reporter](INFO): platform_buoyancy_position 486.021637 cc
2021-11-29T16:51:02.577Z,1638204662.577 [Reporter](INFO): platform_buoyancy_position 481.589752 cc
2021-11-29T16:51:02.941Z,1638204662.941 [Reporter](INFO): platform_buoyancy_position 477.023529 cc
2021-11-29T16:51:03.349Z,1638204663.349 [Reporter](INFO): platform_buoyancy_position 470.845734 cc
2021-11-29T16:51:03.777Z,1638204663.777 [Reporter](INFO): platform_buoyancy_position 465.205170 cc
2021-11-29T16:51:04.172Z,1638204664.172 [Reporter](INFO): platform_buoyancy_position 460.101715 cc
2021-11-29T16:51:04.565Z,1638204664.565 [Reporter](INFO): platform_buoyancy_position 455.804169 cc
2021-11-29T16:51:04.973Z,1638204664.973 [Reporter](INFO): platform_buoyancy_position 451.506561 cc
2021-11-29T16:51:05.391Z,1638204665.391 [Reporter](INFO): platform_buoyancy_position 445.060150 cc
2021-11-29T16:51:05.780Z,1638204665.780 [Reporter](INFO): platform_buoyancy_position 439.016632 cc
2021-11-29T16:51:06.177Z,1638204666.177 [Reporter](INFO): platform_buoyancy_position 434.450470 cc
2021-11-29T16:51:06.600Z,1638204666.600 [Reporter](INFO): platform_buoyancy_position 428.004059 cc
2021-11-29T16:51:06.980Z,1638204666.980 [Reporter](INFO): platform_buoyancy_position 423.572113 cc
2021-11-29T16:51:07.382Z,1638204667.382 [Reporter](INFO): platform_buoyancy_position 418.468719 cc
2021-11-29T16:51:07.801Z,1638204667.801 [Reporter](INFO): platform_buoyancy_position 412.828156 cc
2021-11-29T16:51:08.244Z,1638204668.244 [Reporter](INFO): platform_buoyancy_position 407.187531 cc
2021-11-29T16:51:08.597Z,1638204668.597 [Reporter](INFO): platform_buoyancy_position 402.218445 cc
2021-11-29T16:51:09.003Z,1638204669.003 [Reporter](INFO): platform_buoyancy_position 397.652252 cc
2021-11-29T16:51:09.421Z,1638204669.421 [Reporter](INFO): platform_buoyancy_position 391.340149 cc
2021-11-29T16:51:09.805Z,1638204669.805 [Reporter](INFO): platform_buoyancy_position 387.042542 cc
2021-11-29T16:51:10.227Z,1638204670.227 [Reporter](INFO): platform_buoyancy_position 380.596130 cc
2021-11-29T16:51:10.637Z,1638204670.637 [Reporter](INFO): platform_buoyancy_position 376.164246 cc
2021-11-29T16:51:11.021Z,1638204671.021 [Reporter](INFO): platform_buoyancy_position 369.852142 cc
2021-11-29T16:51:11.431Z,1638204671.431 [Reporter](INFO): platform_buoyancy_position 365.554535 cc
2021-11-29T16:51:11.848Z,1638204671.848 [Reporter](INFO): platform_buoyancy_position 359.108124 cc
2021-11-29T16:51:12.260Z,1638204672.260 [Reporter](INFO): platform_buoyancy_position 354.810547 cc
2021-11-29T16:51:12.633Z,1638204672.633 [Reporter](INFO): platform_buoyancy_position 348.632751 cc
2021-11-29T16:51:13.058Z,1638204673.058 [Reporter](INFO): platform_buoyancy_position 344.200836 cc
2021-11-29T16:51:13.458Z,1638204673.458 [Reporter](INFO): platform_buoyancy_position 337.620148 cc
2021-11-29T16:51:13.841Z,1638204673.841 [Reporter](INFO): platform_buoyancy_position 333.456848 cc
2021-11-29T16:51:14.265Z,1638204674.265 [Reporter](INFO): platform_buoyancy_position 327.816223 cc
2021-11-29T16:51:14.682Z,1638204674.682 [Reporter](INFO): platform_buoyancy_position 322.578522 cc
2021-11-29T16:51:15.059Z,1638204675.059 [Reporter](INFO): platform_buoyancy_position 318.415222 cc
2021-11-29T16:51:15.477Z,1638204675.477 [Reporter](INFO): platform_buoyancy_position 313.983337 cc
2021-11-29T16:51:15.889Z,1638204675.889 [Reporter](INFO): platform_buoyancy_position 307.671234 cc
2021-11-29T16:51:16.269Z,1638204676.269 [Reporter](INFO): platform_buoyancy_position 301.359131 cc
2021-11-29T16:51:16.684Z,1638204676.684 [Reporter](INFO): platform_buoyancy_position 296.927246 cc
2021-11-29T16:51:17.093Z,1638204677.093 [Reporter](INFO): platform_buoyancy_position 290.346527 cc
2021-11-29T16:51:17.481Z,1638204677.481 [Reporter](INFO): platform_buoyancy_position 286.183228 cc
2021-11-29T16:51:17.901Z,1638204677.901 [Reporter](INFO): platform_buoyancy_position 279.736847 cc
2021-11-29T16:51:18.345Z,1638204678.345 [Reporter](INFO): platform_buoyancy_position 275.036346 cc
2021-11-29T16:51:18.722Z,1638204678.722 [Reporter](INFO): platform_buoyancy_position 268.858521 cc
2021-11-29T16:51:19.120Z,1638204679.120 [Reporter](INFO): platform_buoyancy_position 264.695221 cc
2021-11-29T16:51:19.529Z,1638204679.529 [Reporter](INFO): platform_buoyancy_position 258.383118 cc
2021-11-29T16:51:19.926Z,1638204679.926 [Reporter](INFO): platform_buoyancy_position 253.951233 cc
2021-11-29T16:51:20.309Z,1638204680.309 [Reporter](INFO): platform_buoyancy_position 248.444901 cc
2021-11-29T16:51:20.729Z,1638204680.729 [Reporter](INFO): platform_buoyancy_position 243.072937 cc
2021-11-29T16:51:21.148Z,1638204681.148 [Reporter](INFO): platform_buoyancy_position 236.895142 cc
2021-11-29T16:51:21.525Z,1638204681.525 [Reporter](INFO): platform_buoyancy_position 232.328918 cc
2021-11-29T16:51:21.929Z,1638204681.929 [Reporter](INFO): platform_buoyancy_position 226.016815 cc
2021-11-29T16:51:22.337Z,1638204682.337 [Reporter](INFO): platform_buoyancy_position 221.584930 cc
2021-11-29T16:51:22.759Z,1638204682.759 [Reporter](INFO): platform_buoyancy_position 215.944336 cc
2021-11-29T16:51:23.197Z,1638204683.197 [Reporter](INFO): platform_buoyancy_position 210.975220 cc
2021-11-29T16:51:23.577Z,1638204683.577 [Reporter](INFO): platform_buoyancy_position 206.543335 cc
2021-11-29T16:51:54.201Z,1638204714.201 [DAT](INFO): DAT read: Lowpower

2021-11-29T16:51:54.201Z,1638204714.201 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T16:52:21.531Z,1638204741.531 [CommandExec](IMPORTANT): got command get platform_mass_position
2021-11-29T16:52:21.532Z,1638204741.532 [CommandExec](IMPORTANT): platform_mass_position -0.016001 m
2021-11-29T16:52:41.774Z,1638204761.774 [CommandExec](IMPORTANT): got command get VerticalControl.massDefault
2021-11-29T16:52:41.774Z,1638204761.774 [CommandExec](IMPORTANT): VerticalControl.massDefault -1.600000 cm
2021-11-29T16:53:22.113Z,1638204802.113 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -7.000000 millimeter
2021-11-29T16:53:22.130Z,1638204802.130 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread.
2021-11-29T16:53:22.354Z,1638204802.354 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-11-29T16:54:37.772Z,1638204877.772 [CommandExec](IMPORTANT): got command maintain clear
2021-11-29T16:54:37.892Z,1638204877.892 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-11-29T16:54:40.020Z,1638204880.020 [Reporter](INFO): platform_buoyancy_position 195.665039 cc
2021-11-29T16:54:40.366Z,1638204880.366 [Reporter](INFO): platform_buoyancy_position 195.799316 cc
2021-11-29T16:54:40.776Z,1638204880.776 [Reporter](INFO): platform_buoyancy_position 195.933624 cc
2021-11-29T16:54:41.184Z,1638204881.184 [Reporter](INFO): platform_buoyancy_position 200.231232 cc
2021-11-29T16:54:41.579Z,1638204881.579 [Reporter](INFO): platform_buoyancy_position 204.394531 cc
2021-11-29T16:54:41.972Z,1638204881.972 [Reporter](INFO): platform_buoyancy_position 210.572327 cc
2021-11-29T16:54:42.388Z,1638204882.388 [Reporter](INFO): platform_buoyancy_position 215.138519 cc
2021-11-29T16:54:42.796Z,1638204882.796 [Reporter](INFO): platform_buoyancy_position 220.241913 cc
2021-11-29T16:54:43.200Z,1638204883.200 [Reporter](INFO): platform_buoyancy_position 225.882538 cc
2021-11-29T16:54:43.586Z,1638204883.586 [Reporter](INFO): platform_buoyancy_position 230.314423 cc
2021-11-29T16:54:44.004Z,1638204884.004 [Reporter](INFO): platform_buoyancy_position 236.760834 cc
2021-11-29T16:54:44.412Z,1638204884.412 [Reporter](INFO): platform_buoyancy_position 241.058441 cc
2021-11-29T16:54:44.794Z,1638204884.794 [Reporter](INFO): platform_buoyancy_position 247.370544 cc
2021-11-29T16:54:45.200Z,1638204885.200 [Reporter](INFO): platform_buoyancy_position 251.802444 cc
2021-11-29T16:54:45.647Z,1638204885.647 [Reporter](INFO): platform_buoyancy_position 258.248840 cc
2021-11-29T16:54:46.016Z,1638204886.016 [Reporter](INFO): platform_buoyancy_position 262.546417 cc
2021-11-29T16:54:46.408Z,1638204886.408 [Reporter](INFO): platform_buoyancy_position 268.858521 cc
2021-11-29T16:54:46.833Z,1638204886.833 [Reporter](INFO): platform_buoyancy_position 273.290436 cc
2021-11-29T16:54:47.272Z,1638204887.272 [Reporter](INFO): platform_buoyancy_position 279.736847 cc
2021-11-29T16:54:47.663Z,1638204887.663 [Reporter](INFO): platform_buoyancy_position 283.900146 cc
2021-11-29T16:54:48.060Z,1638204888.060 [Reporter](INFO): platform_buoyancy_position 290.346527 cc
2021-11-29T16:54:48.469Z,1638204888.469 [Reporter](INFO): platform_buoyancy_position 294.778442 cc
2021-11-29T16:54:48.872Z,1638204888.872 [Reporter](INFO): platform_buoyancy_position 299.210327 cc
2021-11-29T16:54:49.277Z,1638204889.277 [Reporter](INFO): platform_buoyancy_position 305.522430 cc
2021-11-29T16:54:49.701Z,1638204889.701 [Reporter](INFO): platform_buoyancy_position 311.565948 cc
2021-11-29T16:54:50.095Z,1638204890.095 [Reporter](INFO): platform_buoyancy_position 314.117645 cc
2021-11-29T16:54:50.460Z,1638204890.460 [Reporter](INFO): platform_buoyancy_position 320.564026 cc
2021-11-29T16:54:50.883Z,1638204890.883 [Reporter](INFO): platform_buoyancy_position 326.876129 cc
2021-11-29T16:54:51.312Z,1638204891.312 [Reporter](INFO): platform_buoyancy_position 331.308044 cc
2021-11-29T16:54:51.695Z,1638204891.695 [Reporter](INFO): platform_buoyancy_position 337.485840 cc
2021-11-29T16:54:52.183Z,1638204892.183 [Reporter](INFO): platform_buoyancy_position 341.917725 cc
2021-11-29T16:54:52.473Z,1638204892.473 [Reporter](INFO): platform_buoyancy_position 348.364136 cc
2021-11-29T16:54:52.869Z,1638204892.869 [Reporter](INFO): platform_buoyancy_position 352.796051 cc
2021-11-29T16:54:53.284Z,1638204893.284 [Reporter](INFO): platform_buoyancy_position 359.108124 cc
2021-11-29T16:54:53.697Z,1638204893.697 [Reporter](INFO): platform_buoyancy_position 363.540039 cc
2021-11-29T16:54:54.087Z,1638204894.087 [Reporter](INFO): platform_buoyancy_position 368.374847 cc
2021-11-29T16:54:54.499Z,1638204894.499 [Reporter](INFO): platform_buoyancy_position 374.149750 cc
2021-11-29T16:54:54.913Z,1638204894.913 [Reporter](INFO): platform_buoyancy_position 380.596130 cc
2021-11-29T16:54:55.336Z,1638204895.336 [Reporter](INFO): platform_buoyancy_position 385.162354 cc
2021-11-29T16:54:55.733Z,1638204895.733 [Reporter](INFO): platform_buoyancy_position 391.474426 cc
2021-11-29T16:54:56.133Z,1638204896.133 [Reporter](INFO): platform_buoyancy_position 395.772034 cc
2021-11-29T16:54:56.513Z,1638204896.513 [Reporter](INFO): platform_buoyancy_position 400.338226 cc
2021-11-29T16:54:56.910Z,1638204896.910 [Reporter](INFO): platform_buoyancy_position 406.516052 cc
2021-11-29T16:54:57.293Z,1638204897.293 [Reporter](INFO): platform_buoyancy_position 410.813629 cc
2021-11-29T16:54:57.709Z,1638204897.709 [Reporter](INFO): platform_buoyancy_position 417.125763 cc
2021-11-29T16:54:58.132Z,1638204898.132 [Reporter](INFO): platform_buoyancy_position 421.423370 cc
2021-11-29T16:54:58.509Z,1638204898.509 [Reporter](INFO): platform_buoyancy_position 426.929657 cc
2021-11-29T16:54:58.925Z,1638204898.925 [Reporter](INFO): platform_buoyancy_position 432.301666 cc
2021-11-29T16:54:59.333Z,1638204899.333 [Reporter](INFO): platform_buoyancy_position 438.076569 cc
2021-11-29T16:54:59.721Z,1638204899.721 [Reporter](INFO): platform_buoyancy_position 442.911346 cc
2021-11-29T16:55:00.132Z,1638204900.132 [Reporter](INFO): platform_buoyancy_position 447.343231 cc
2021-11-29T16:55:00.549Z,1638204900.549 [Reporter](INFO): platform_buoyancy_position 453.386749 cc
2021-11-29T16:55:00.953Z,1638204900.953 [Reporter](INFO): platform_buoyancy_position 457.952972 cc
2021-11-29T16:55:01.329Z,1638204901.329 [Reporter](INFO): platform_buoyancy_position 464.399323 cc
2021-11-29T16:55:01.760Z,1638204901.760 [Reporter](INFO): platform_buoyancy_position 468.965546 cc
2021-11-29T16:55:02.179Z,1638204902.179 [Reporter](INFO): platform_buoyancy_position 475.143341 cc
2021-11-29T16:55:02.581Z,1638204902.581 [Reporter](INFO): platform_buoyancy_position 479.709564 cc
2021-11-29T16:55:02.953Z,1638204902.953 [Reporter](INFO): platform_buoyancy_position 485.753021 cc
2021-11-29T16:55:03.365Z,1638204903.365 [Reporter](INFO): platform_buoyancy_position 490.319214 cc
2021-11-29T16:55:03.785Z,1638204903.785 [Reporter](INFO): platform_buoyancy_position 496.631378 cc
2021-11-29T16:55:04.160Z,1638204904.160 [Reporter](INFO): platform_buoyancy_position 501.063232 cc
2021-11-29T16:55:04.576Z,1638204904.576 [Reporter](INFO): platform_buoyancy_position 507.375336 cc
2021-11-29T16:55:04.981Z,1638204904.981 [Reporter](INFO): platform_buoyancy_position 511.941559 cc
2021-11-29T16:55:05.386Z,1638204905.386 [Reporter](INFO): platform_buoyancy_position 518.253601 cc
2021-11-29T16:55:05.809Z,1638204905.809 [Reporter](INFO): platform_buoyancy_position 522.551208 cc
2021-11-29T16:55:06.191Z,1638204906.191 [Reporter](INFO): platform_buoyancy_position 528.863342 cc
2021-11-29T16:55:06.601Z,1638204906.601 [Reporter](INFO): platform_buoyancy_position 533.295227 cc
2021-11-29T16:55:07.023Z,1638204907.023 [Reporter](INFO): platform_buoyancy_position 539.607300 cc
2021-11-29T16:55:07.396Z,1638204907.396 [Reporter](INFO): platform_buoyancy_position 543.904907 cc
2021-11-29T16:55:07.820Z,1638204907.820 [Reporter](INFO): platform_buoyancy_position 550.351318 cc
2021-11-29T16:55:08.213Z,1638204908.213 [Reporter](INFO): platform_buoyancy_position 554.648926 cc
2021-11-29T16:55:08.628Z,1638204908.628 [Reporter](INFO): platform_buoyancy_position 559.349426 cc
2021-11-29T16:55:09.032Z,1638204909.032 [Reporter](INFO): platform_buoyancy_position 565.392944 cc
2021-11-29T16:55:09.419Z,1638204909.419 [Reporter](INFO): platform_buoyancy_position 569.959106 cc
2021-11-29T16:55:09.845Z,1638204909.845 [Reporter](INFO): platform_buoyancy_position 576.136902 cc
2021-11-29T16:55:10.229Z,1638204910.229 [Reporter](INFO): platform_buoyancy_position 580.568848 cc
2021-11-29T16:55:10.632Z,1638204910.632 [Reporter](INFO): platform_buoyancy_position 586.880920 cc
2021-11-29T16:55:11.062Z,1638204911.062 [Reporter](INFO): platform_buoyancy_position 591.312805 cc
2021-11-29T16:55:11.446Z,1638204911.446 [Reporter](INFO): platform_buoyancy_position 595.744751 cc
2021-11-29T16:55:11.840Z,1638204911.840 [Reporter](INFO): platform_buoyancy_position 602.056824 cc
2021-11-29T16:55:12.263Z,1638204912.263 [Reporter](INFO): platform_buoyancy_position 606.488708 cc
2021-11-29T16:55:12.672Z,1638204912.672 [Reporter](INFO): platform_buoyancy_position 612.800842 cc
2021-11-29T16:55:13.082Z,1638204913.082 [Reporter](INFO): platform_buoyancy_position 619.112915 cc
2021-11-29T16:55:13.503Z,1638204913.503 [Reporter](INFO): platform_buoyancy_position 623.544800 cc
2021-11-29T16:55:13.884Z,1638204913.884 [Reporter](INFO): platform_buoyancy_position 628.513916 cc
2021-11-29T16:55:14.276Z,1638204914.276 [Reporter](INFO): platform_buoyancy_position 634.288818 cc
2021-11-29T16:55:14.685Z,1638204914.685 [Reporter](INFO): platform_buoyancy_position 638.720703 cc
2021-11-29T16:55:15.086Z,1638204915.086 [Reporter](INFO): platform_buoyancy_position 644.898499 cc
2021-11-29T16:55:15.476Z,1638204915.476 [Reporter](INFO): platform_buoyancy_position 649.330444 cc
2021-11-29T16:55:15.893Z,1638204915.893 [Reporter](INFO): platform_buoyancy_position 655.776855 cc
2021-11-29T16:55:16.306Z,1638204916.306 [Reporter](INFO): platform_buoyancy_position 660.074402 cc
2021-11-29T16:55:16.677Z,1638204916.677 [Reporter](INFO): platform_buoyancy_position 666.386536 cc
2021-11-29T16:55:17.105Z,1638204917.105 [Reporter](INFO): platform_buoyancy_position 670.818420 cc
2021-11-29T16:55:17.520Z,1638204917.520 [Reporter](INFO): platform_buoyancy_position 677.130554 cc
2021-11-29T16:55:17.901Z,1638204917.901 [Reporter](INFO): platform_buoyancy_position 681.562439 cc
2021-11-29T16:55:18.323Z,1638204918.323 [Reporter](INFO): platform_buoyancy_position 686.262939 cc
2021-11-29T16:55:18.732Z,1638204918.732 [Reporter](INFO): platform_buoyancy_position 692.172119 cc
2021-11-29T16:55:19.134Z,1638204919.134 [Reporter](INFO): platform_buoyancy_position 696.738342 cc
2021-11-29T16:55:19.524Z,1638204919.524 [Reporter](INFO): platform_buoyancy_position 702.916138 cc
2021-11-29T16:55:19.772Z,1638204919.772 [CTD_Seabird](ERROR): Salinity reading out of range: 6.569429 psu
2021-11-29T16:55:19.925Z,1638204919.925 [Reporter](INFO): platform_buoyancy_position 707.750916 cc
2021-11-29T16:55:20.349Z,1638204920.349 [Reporter](INFO): platform_buoyancy_position 713.794434 cc
2021-11-29T16:55:20.752Z,1638204920.752 [Reporter](INFO): platform_buoyancy_position 718.226318 cc
2021-11-29T16:55:20.776Z,1638204920.776 [CTD_Seabird](ERROR): Salinity reading out of range: 2.721637 psu
2021-11-29T16:55:21.140Z,1638204921.140 [Reporter](INFO): platform_buoyancy_position 724.404114 cc
2021-11-29T16:55:21.541Z,1638204921.541 [Reporter](INFO): platform_buoyancy_position 728.970337 cc
2021-11-29T16:55:21.780Z,1638204921.780 [CTD_Seabird](ERROR): Salinity reading out of range: 4.649332 psu
2021-11-29T16:55:21.953Z,1638204921.953 [Reporter](INFO): platform_buoyancy_position 735.148132 cc
2021-11-29T16:55:22.364Z,1638204922.364 [Reporter](INFO): platform_buoyancy_position 739.580017 cc
2021-11-29T16:55:22.753Z,1638204922.753 [Reporter](INFO): platform_buoyancy_position 744.683411 cc
2021-11-29T16:55:22.785Z,1638204922.785 [CTD_Seabird](ERROR): Salinity reading out of range: 8.676456 psu
2021-11-29T16:55:23.180Z,1638204923.180 [Reporter](INFO): platform_buoyancy_position 750.189758 cc
2021-11-29T16:55:23.568Z,1638204923.568 [Reporter](INFO): platform_buoyancy_position 756.636108 cc
2021-11-29T16:55:23.788Z,1638204923.788 [CTD_Seabird](ERROR): Salinity reading out of range: 1.953984 psu
2021-11-29T16:55:23.960Z,1638204923.960 [Reporter](INFO): platform_buoyancy_position 760.933716 cc
2021-11-29T16:55:24.377Z,1638204924.377 [Reporter](INFO): platform_buoyancy_position 765.365662 cc
2021-11-29T16:55:24.792Z,1638204924.792 [CTD_Seabird](ERROR): Salinity reading out of range: 16.387400 psu
2021-11-29T16:55:24.794Z,1638204924.794 [Reporter](INFO): platform_buoyancy_position 771.677734 cc
2021-11-29T16:55:25.173Z,1638204925.173 [Reporter](INFO): platform_buoyancy_position 776.378235 cc
2021-11-29T16:55:25.592Z,1638204925.592 [Reporter](INFO): platform_buoyancy_position 782.421753 cc
2021-11-29T16:55:25.998Z,1638204925.998 [Reporter](INFO): platform_buoyancy_position 786.987915 cc
2021-11-29T16:55:26.397Z,1638204926.397 [Reporter](INFO): platform_buoyancy_position 793.165710 cc
2021-11-29T16:55:26.794Z,1638204926.794 [Reporter](INFO): platform_buoyancy_position 797.597656 cc
2021-11-29T16:55:27.205Z,1638204927.205 [Reporter](INFO): platform_buoyancy_position 803.909729 cc
2021-11-29T16:55:27.608Z,1638204927.608 [Reporter](INFO): platform_buoyancy_position 808.341614 cc
2021-11-29T16:55:28.034Z,1638204928.034 [Reporter](INFO): platform_buoyancy_position 814.653748 cc
2021-11-29T16:55:28.420Z,1638204928.420 [Reporter](INFO): platform_buoyancy_position 818.951355 cc
2021-11-29T16:55:28.836Z,1638204928.836 [Reporter](INFO): platform_buoyancy_position 824.054749 cc
2021-11-29T16:55:29.236Z,1638204929.236 [Reporter](INFO): platform_buoyancy_position 829.829651 cc
2021-11-29T16:55:29.613Z,1638204929.613 [Reporter](INFO): platform_buoyancy_position 834.261536 cc
2021-11-29T16:55:30.033Z,1638204930.033 [Reporter](INFO): platform_buoyancy_position 840.439331 cc
2021-11-29T16:55:30.445Z,1638204930.445 [Reporter](INFO): platform_buoyancy_position 845.542725 cc
2021-11-29T16:55:30.857Z,1638204930.857 [Reporter](INFO): platform_buoyancy_position 851.317627 cc
2021-11-29T16:55:31.225Z,1638204931.225 [Reporter](INFO): platform_buoyancy_position 855.749573 cc
2021-11-29T16:55:31.645Z,1638204931.645 [Reporter](INFO): platform_buoyancy_position 861.927368 cc
2021-11-29T16:55:32.065Z,1638204932.065 [Reporter](INFO): platform_buoyancy_position 866.359253 cc
2021-11-29T16:55:32.480Z,1638204932.480 [Reporter](INFO): platform_buoyancy_position 872.671326 cc
2021-11-29T16:55:32.849Z,1638204932.849 [Reporter](INFO): platform_buoyancy_position 877.103271 cc
2021-11-29T16:55:33.275Z,1638204933.275 [Reporter](INFO): platform_buoyancy_position 883.415344 cc
2021-11-29T16:55:33.677Z,1638204933.677 [Reporter](INFO): platform_buoyancy_position 887.981567 cc
2021-11-29T16:55:34.067Z,1638204934.067 [Reporter](INFO): platform_buoyancy_position 894.159363 cc
2021-11-29T16:55:34.483Z,1638204934.483 [Reporter](INFO): platform_buoyancy_position 898.725525 cc
2021-11-29T16:55:34.848Z,1638204934.848 [CTD_Seabird](ERROR): Salinity reading out of range: 19.149929 psu
2021-11-29T16:55:34.897Z,1638204934.897 [Reporter](INFO): platform_buoyancy_position 904.903320 cc
2021-11-29T16:55:35.269Z,1638204935.269 [Reporter](INFO): platform_buoyancy_position 909.200928 cc
2021-11-29T16:55:35.684Z,1638204935.684 [Reporter](INFO): platform_buoyancy_position 913.632874 cc
2021-11-29T16:55:36.094Z,1638204936.094 [Reporter](INFO): platform_buoyancy_position 919.944946 cc
2021-11-29T16:55:36.509Z,1638204936.509 [Reporter](INFO): platform_buoyancy_position 924.376831 cc
2021-11-29T16:55:36.856Z,1638204936.856 [CTD_Seabird](ERROR): Salinity reading out of range: 20.552805 psu
2021-11-29T16:55:36.906Z,1638204936.906 [Reporter](INFO): platform_buoyancy_position 930.688965 cc
2021-11-29T16:55:37.334Z,1638204937.334 [Reporter](INFO): platform_buoyancy_position 935.120850 cc
2021-11-29T16:55:37.860Z,1638204937.860 [CTD_Seabird](ERROR): Salinity reading out of range: 19.772539 psu
2021-11-29T16:55:38.864Z,1638204938.864 [CTD_Seabird](ERROR): Salinity reading out of range: 25.966228 psu
2021-11-29T16:55:39.868Z,1638204939.868 [CTD_Seabird](ERROR): Salinity reading out of range: 20.558556 psu
2021-11-29T16:55:40.872Z,1638204940.872 [CTD_Seabird](ERROR): Salinity reading out of range: 15.258427 psu
2021-11-29T16:55:41.876Z,1638204941.876 [CTD_Seabird](ERROR): Salinity reading out of range: 4.190006 psu
2021-11-29T16:55:42.880Z,1638204942.880 [CTD_Seabird](ERROR): Salinity reading out of range: 14.469720 psu
2021-11-29T16:55:43.884Z,1638204943.884 [CTD_Seabird](ERROR): Salinity reading out of range: 2.838216 psu
2021-11-29T16:55:44.889Z,1638204944.889 [CTD_Seabird](ERROR): Salinity reading out of range: 10.146758 psu
2021-11-29T16:55:45.893Z,1638204945.893 [CTD_Seabird](ERROR): Salinity reading out of range: 3.671041 psu
2021-11-29T16:55:46.896Z,1638204946.896 [CTD_Seabird](ERROR): Salinity reading out of range: 2.324133 psu
2021-11-29T16:55:47.900Z,1638204947.900 [CTD_Seabird](ERROR): Salinity reading out of range: 2.426918 psu
2021-11-29T16:55:48.904Z,1638204948.904 [CTD_Seabird](ERROR): Salinity reading out of range: 2.277810 psu
2021-11-29T16:55:49.909Z,1638204949.909 [CTD_Seabird](ERROR): Salinity reading out of range: 1.794983 psu
2021-11-29T16:55:50.912Z,1638204950.912 [CTD_Seabird](ERROR): Salinity reading out of range: 1.572445 psu
2021-11-29T16:55:51.916Z,1638204951.916 [CTD_Seabird](ERROR): Salinity reading out of range: 1.424605 psu
2021-11-29T16:55:52.920Z,1638204952.920 [CTD_Seabird](ERROR): Salinity reading out of range: 1.648988 psu
2021-11-29T16:55:53.925Z,1638204953.925 [CTD_Seabird](ERROR): Salinity reading out of range: 1.837406 psu
2021-11-29T16:55:54.928Z,1638204954.928 [CTD_Seabird](ERROR): Salinity reading out of range: 1.612773 psu
2021-11-29T16:55:55.932Z,1638204955.932 [CTD_Seabird](ERROR): Salinity reading out of range: 1.032304 psu
2021-11-29T16:55:56.936Z,1638204956.936 [CTD_Seabird](ERROR): Salinity reading out of range: 0.698588 psu
2021-11-29T16:55:57.942Z,1638204957.942 [CTD_Seabird](ERROR): Salinity reading out of range: 0.620847 psu
2021-11-29T16:55:58.946Z,1638204958.946 [CTD_Seabird](ERROR): Salinity reading out of range: 0.589735 psu
2021-11-29T16:55:59.949Z,1638204959.949 [CTD_Seabird](ERROR): Salinity reading out of range: 0.529834 psu
2021-11-29T16:56:00.953Z,1638204960.953 [CTD_Seabird](ERROR): Salinity reading out of range: 0.569936 psu
2021-11-29T16:56:01.957Z,1638204961.957 [CTD_Seabird](ERROR): Salinity reading out of range: 1.157366 psu
2021-11-29T16:56:02.961Z,1638204962.961 [CTD_Seabird](ERROR): Salinity reading out of range: 1.025894 psu
2021-11-29T16:56:03.175Z,1638204963.175 [CommandExec](IMPORTANT): got command stop
2021-11-29T16:56:03.175Z,1638204963.175 [CommandExec](IMPORTANT): Scheduling is paused
2021-11-29T16:56:03.176Z,1638204963.176 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2021-11-29T16:56:03.520Z,1638204963.520 [MissionManager](INFO): MissionManager is completed.
2021-11-29T16:56:03.520Z,1638204963.520 [MissionManager](INFO): Uninitializing Mission Science
2021-11-29T16:56:03.520Z,1638204963.520 [Science] Stopped
2021-11-29T16:56:03.520Z,1638204963.520 [Science](DEBUG): Aggregate::uninitialize Science
2021-11-29T16:56:03.520Z,1638204963.520 [Science:B] Stopped
2021-11-29T16:56:03.520Z,1638204963.520 [Science:C] Stopped
2021-11-29T16:56:03.520Z,1638204963.520 [Science:E] Stopped
2021-11-29T16:56:03.520Z,1638204963.520 [Science:OceanCurrent] Stopped
2021-11-29T16:56:03.520Z,1638204963.520 [Science:OceanCurrent](DEBUG): Aggregate::uninitialize Science:OceanCurrent
2021-11-29T16:56:03.521Z,1638204963.521 [Science:OceanCurrent:A.] Stopped
2021-11-29T16:56:03.762Z,1638204963.762 [WetLabsBB2FL](INFO): Powering down
2021-11-29T16:56:03.921Z,1638204963.921 [MissionManager](IMPORTANT): Started mission Default
2021-11-29T16:56:03.921Z,1638204963.921 [Default] Running Loop=1
2021-11-29T16:56:03.921Z,1638204963.921 [Default](DEBUG): Aggregate::initialize Default
2021-11-29T16:56:03.921Z,1638204963.921 [Default:B.GoToSurface] Running Loop=1
2021-11-29T16:56:03.921Z,1638204963.921 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2021-11-29T16:56:03.922Z,1638204963.922 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2021-11-29T16:56:03.922Z,1638204963.922 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2021-11-29T16:56:03.922Z,1638204963.922 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2021-11-29T16:56:03.923Z,1638204963.923 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2021-11-29T16:56:03.923Z,1638204963.923 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2021-11-29T16:56:03.924Z,1638204963.924 [Default:A.Wait] Running Loop=1
2021-11-29T16:56:03.924Z,1638204963.924 [Default:A.Wait](DEBUG): Initialize Wait Component.
2021-11-29T16:56:06.009Z,1638204966.009 [Reporter](INFO): platform_buoyancy_position 943.581787 cc
2021-11-29T16:56:06.796Z,1638204966.796 [Reporter](INFO): platform_buoyancy_position 943.984619 cc
2021-11-29T16:56:07.232Z,1638204967.232 [Reporter](INFO): platform_buoyancy_position 948.013672 cc
2021-11-29T16:56:17.296Z,1638204977.296 [Default:A.Wait](INFO): Done Waiting.
2021-11-29T16:56:17.296Z,1638204977.296 [Default:A.Wait] Stopped
2021-11-29T16:56:17.296Z,1638204977.296 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T16:56:17.707Z,1638204977.707 [Default:CheckIn] Running Loop=1
2021-11-29T16:56:17.708Z,1638204977.708 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T16:56:17.708Z,1638204977.708 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T16:56:19.658Z,1638204979.658 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165617.00,A,3648.16703,N,12147.28051,W,0.525,0.00,291121,,,A*71
2021-11-29T16:56:19.660Z,1638204979.660 [NAL9602](INFO): GPS fix at 20211129T165617: (36.802784, -121.788009)
2021-11-29T16:56:19.720Z,1638204979.720 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T16:56:19.720Z,1638204979.720 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T16:56:20.509Z,1638204980.509 [DAT](INFO): #Outgoing data=1
2021-11-29T16:56:20.509Z,1638204980.509 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:56:20.909Z,1638204980.909 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:56:21.365Z,1638204981.365 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T16:56:21.366Z,1638204981.366 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T16:56:21.367Z,1638204981.367 [DAT](INFO): commRate: 1200
2021-11-29T16:56:24.555Z,1638204984.555 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:55:48.4347

2021-11-29T16:56:24.555Z,1638204984.555 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:56:34.663Z,1638204994.663 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:56:34.663Z,1638204994.663 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:56:35.068Z,1638204995.068 [DAT](INFO): Sent 184 bytes from file Logs/20211129T161830/Courier0013.lzma.parts
2021-11-29T16:56:35.068Z,1638204995.068 [DAT](INFO): Packets left to send: 1
2021-11-29T16:56:35.070Z,1638204995.070 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:56:35.460Z,1638204995.460 [DAT](INFO): #Outgoing data=1
2021-11-29T16:56:35.460Z,1638204995.460 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T16:56:35.869Z,1638204995.869 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T16:56:39.116Z,1638204999.116 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:56:03.2311

2021-11-29T16:56:39.116Z,1638204999.116 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T16:56:49.193Z,1638205009.193 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T16:56:49.193Z,1638205009.193 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T16:56:49.601Z,1638205009.601 [DAT](INFO): Sent 39 bytes from file Logs/20211129T161830/Courier0013.lzma.parts
2021-11-29T16:56:49.601Z,1638205009.601 [DAT](INFO): Packets left to send: 0
2021-11-29T16:56:49.611Z,1638205009.611 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T16:56:50.029Z,1638205010.029 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T16:56:50.029Z,1638205010.029 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T16:56:50.029Z,1638205010.029 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T16:57:22.731Z,1638205042.731 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T16:59:39.276Z,1638205179.276 [DAT](INFO): DAT read: Lowpower

2021-11-29T16:59:39.277Z,1638205179.277 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:01:50.587Z,1638205310.587 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T17:01:50.587Z,1638205310.587 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:01:50.587Z,1638205310.587 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:01:50.588Z,1638205310.588 [Default:CheckIn:D] Running Loop=1
2021-11-29T17:01:51.009Z,1638205311.009 [Default:CheckIn:D] Stopped
2021-11-29T17:01:51.014Z,1638205311.014 [Default:CheckIn:E] Running Loop=1
2021-11-29T17:01:51.409Z,1638205311.409 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 5.784786 min 
2021-11-29T17:01:51.410Z,1638205311.410 [Default:CheckIn:E] Stopped
2021-11-29T17:01:51.411Z,1638205311.411 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T17:01:51.411Z,1638205311.411 [Default:CheckIn] Stopped
2021-11-29T17:01:51.412Z,1638205311.412 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:01:51.413Z,1638205311.413 [Default:CheckIn](INFO): Running loop #2
2021-11-29T17:01:51.413Z,1638205311.413 [Default:CheckIn] Running Loop=2
2021-11-29T17:01:51.414Z,1638205311.414 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T17:01:51.414Z,1638205311.414 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T17:01:53.417Z,1638205313.417 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170152.00,A,3648.16469,N,12147.28163,W,0.233,352.63,291121,,,A*7D
2021-11-29T17:01:53.421Z,1638205313.421 [NAL9602](INFO): GPS fix at 20211129T170152: (36.802745, -121.788027)
2021-11-29T17:01:53.465Z,1638205313.465 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T17:01:53.465Z,1638205313.465 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T17:01:54.223Z,1638205314.223 [DAT](INFO): #Outgoing data=1
2021-11-29T17:01:54.223Z,1638205314.223 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T17:01:54.655Z,1638205314.655 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T17:01:55.059Z,1638205315.059 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T17:01:55.060Z,1638205315.060 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T17:01:55.060Z,1638205315.060 [DAT](INFO): commRate: 1200
2021-11-29T17:01:58.271Z,1638205318.271 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:01:21.3321

2021-11-29T17:01:58.271Z,1638205318.271 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T17:02:08.357Z,1638205328.357 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T17:02:08.357Z,1638205328.357 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T17:02:08.793Z,1638205328.793 [DAT](INFO): Sent 72 bytes from file Logs/20211129T161830/Courier0016.lzma.parts
2021-11-29T17:02:08.794Z,1638205328.794 [DAT](INFO): Packets left to send: 0
2021-11-29T17:02:08.796Z,1638205328.796 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T17:02:09.179Z,1638205329.179 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T17:02:09.179Z,1638205329.179 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T17:02:09.179Z,1638205329.179 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T17:02:41.079Z,1638205361.079 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T17:04:58.032Z,1638205498.032 [DAT](INFO): DAT read: Lowpower

2021-11-29T17:04:58.033Z,1638205498.033 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:07:09.763Z,1638205629.763 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T17:07:09.763Z,1638205629.763 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:07:09.763Z,1638205629.763 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:07:09.764Z,1638205629.764 [Default:CheckIn:D] Running Loop=1
2021-11-29T17:07:10.151Z,1638205630.151 [Default:CheckIn:D] Stopped
2021-11-29T17:07:10.151Z,1638205630.151 [Default:CheckIn:E] Running Loop=1
2021-11-29T17:07:10.559Z,1638205630.559 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.103826 min 
2021-11-29T17:07:10.559Z,1638205630.559 [Default:CheckIn:E] Stopped
2021-11-29T17:07:10.559Z,1638205630.559 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T17:07:10.560Z,1638205630.560 [Default:CheckIn] Stopped
2021-11-29T17:07:10.560Z,1638205630.560 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:07:10.560Z,1638205630.560 [Default:CheckIn](INFO): Running loop #3
2021-11-29T17:07:10.560Z,1638205630.560 [Default:CheckIn] Running Loop=3
2021-11-29T17:07:10.560Z,1638205630.560 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T17:07:10.560Z,1638205630.560 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T17:07:12.566Z,1638205632.566 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170711.00,A,3648.17115,N,12147.28037,W,0.447,170.43,291121,,,A*76
2021-11-29T17:07:12.568Z,1638205632.568 [NAL9602](INFO): GPS fix at 20211129T170711: (36.802853, -121.788006)
2021-11-29T17:07:12.620Z,1638205632.620 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T17:07:12.620Z,1638205632.620 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T17:07:13.380Z,1638205633.380 [DAT](INFO): #Outgoing data=1
2021-11-29T17:07:13.380Z,1638205633.380 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T17:07:13.794Z,1638205633.794 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T17:07:14.211Z,1638205634.211 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T17:07:14.213Z,1638205634.213 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T17:07:14.213Z,1638205634.213 [DAT](INFO): commRate: 1200
2021-11-29T17:07:17.420Z,1638205637.420 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:06:40.3326

2021-11-29T17:07:17.420Z,1638205637.420 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T17:07:27.539Z,1638205647.539 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T17:07:27.540Z,1638205647.540 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T17:07:27.944Z,1638205647.944 [DAT](INFO): Sent 73 bytes from file Logs/20211129T161830/Courier0019.lzma.parts
2021-11-29T17:07:27.944Z,1638205647.944 [DAT](INFO): Packets left to send: 0
2021-11-29T17:07:27.947Z,1638205647.947 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T17:07:28.339Z,1638205648.339 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T17:07:28.339Z,1638205648.339 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T17:07:28.339Z,1638205648.339 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T17:07:59.427Z,1638205679.427 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T17:10:17.193Z,1638205817.193 [DAT](INFO): DAT read: Lowpower

2021-11-29T17:10:17.194Z,1638205817.194 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:12:28.906Z,1638205948.906 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T17:12:28.906Z,1638205948.906 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:12:28.906Z,1638205948.906 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:12:28.906Z,1638205948.906 [Default:CheckIn:D] Running Loop=1
2021-11-29T17:12:29.339Z,1638205949.339 [Default:CheckIn:D] Stopped
2021-11-29T17:12:29.339Z,1638205949.339 [Default:CheckIn:E] Running Loop=1
2021-11-29T17:12:29.781Z,1638205949.781 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 16.423628 min 
2021-11-29T17:12:29.781Z,1638205949.781 [Default:CheckIn:E] Stopped
2021-11-29T17:12:29.781Z,1638205949.781 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T17:12:29.781Z,1638205949.781 [Default:CheckIn] Stopped
2021-11-29T17:12:29.782Z,1638205949.782 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:12:29.782Z,1638205949.782 [Default:CheckIn](INFO): Running loop #4
2021-11-29T17:12:29.786Z,1638205949.786 [Default:CheckIn] Running Loop=4
2021-11-29T17:12:29.786Z,1638205949.786 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T17:12:29.786Z,1638205949.786 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T17:12:31.729Z,1638205951.729 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171231.00,A,3648.15180,N,12147.27579,W,0.641,170.43,291121,,,A*7A
2021-11-29T17:12:31.732Z,1638205951.732 [NAL9602](INFO): GPS fix at 20211129T171231: (36.802530, -121.787930)
2021-11-29T17:12:31.772Z,1638205951.772 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T17:12:31.772Z,1638205951.772 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T17:12:32.539Z,1638205952.539 [DAT](INFO): #Outgoing data=1
2021-11-29T17:12:32.539Z,1638205952.539 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T17:12:32.937Z,1638205952.937 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T17:12:33.345Z,1638205953.345 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T17:12:33.346Z,1638205953.346 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T17:12:33.347Z,1638205953.347 [DAT](INFO): commRate: 1200
2021-11-29T17:12:36.208Z,1638205956.208 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:12:00.3343

2021-11-29T17:12:36.208Z,1638205956.208 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T17:12:46.352Z,1638205966.352 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T17:12:46.352Z,1638205966.352 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T17:12:46.744Z,1638205966.744 [DAT](INFO): Sent 73 bytes from file Logs/20211129T161830/Courier0022.lzma.parts
2021-11-29T17:12:46.745Z,1638205966.745 [DAT](INFO): Packets left to send: 0
2021-11-29T17:12:46.749Z,1638205966.749 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T17:12:47.193Z,1638205967.193 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T17:12:47.193Z,1638205967.193 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T17:12:47.193Z,1638205967.193 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T17:12:52.817Z,1638205972.817 [NAL9602](INFO): SBD MO Status=2, MOMSN=30446, MT Status=2, MTMSN=0
2021-11-29T17:12:52.817Z,1638205972.817 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-11-29T17:13:23.504Z,1638206003.504 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T17:15:36.421Z,1638206136.421 [DAT](INFO): DAT read: Lowpower

2021-11-29T17:15:36.421Z,1638206136.421 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:17:47.749Z,1638206267.749 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T17:17:47.749Z,1638206267.749 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:17:47.749Z,1638206267.749 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:17:47.750Z,1638206267.750 [Default:CheckIn:D] Running Loop=1
2021-11-29T17:17:48.144Z,1638206268.144 [Default:CheckIn:D] Stopped
2021-11-29T17:17:48.144Z,1638206268.144 [Default:CheckIn:E] Running Loop=1
2021-11-29T17:17:48.543Z,1638206268.543 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.737046 min 
2021-11-29T17:17:48.543Z,1638206268.543 [Default:CheckIn:E] Stopped
2021-11-29T17:17:48.543Z,1638206268.543 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T17:17:48.543Z,1638206268.543 [Default:CheckIn] Stopped
2021-11-29T17:17:48.543Z,1638206268.543 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:17:48.544Z,1638206268.544 [Default:CheckIn](INFO): Running loop #5
2021-11-29T17:17:48.544Z,1638206268.544 [Default:CheckIn] Running Loop=5
2021-11-29T17:17:48.544Z,1638206268.544 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T17:17:48.544Z,1638206268.544 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T17:17:50.562Z,1638206270.562 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,171749.00,A,3648.17237,N,12147.27918,W,0.389,299.78,291121,,,A*7B
2021-11-29T17:17:50.564Z,1638206270.564 [NAL9602](INFO): GPS fix at 20211129T171749: (36.802873, -121.787986)
2021-11-29T17:17:50.576Z,1638206270.576 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T17:17:50.576Z,1638206270.576 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T17:17:51.366Z,1638206271.366 [DAT](INFO): #Outgoing data=1
2021-11-29T17:17:51.366Z,1638206271.366 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T17:17:51.774Z,1638206271.774 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T17:17:52.203Z,1638206272.203 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T17:17:52.205Z,1638206272.205 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T17:17:52.205Z,1638206272.205 [DAT](INFO): commRate: 1200
2021-11-29T17:17:55.012Z,1638206275.012 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:17:18.3290

2021-11-29T17:17:55.012Z,1638206275.012 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T17:18:05.131Z,1638206285.131 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T17:18:05.131Z,1638206285.131 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T17:18:05.501Z,1638206285.501 [DAT](INFO): Sent 73 bytes from file Logs/20211129T161830/Courier0025.lzma.parts
2021-11-29T17:18:05.502Z,1638206285.502 [DAT](INFO): Packets left to send: 0
2021-11-29T17:18:05.504Z,1638206285.504 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T17:18:05.919Z,1638206285.919 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T17:18:05.919Z,1638206285.919 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T17:18:05.919Z,1638206285.919 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T17:18:39.039Z,1638206319.039 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T17:20:55.180Z,1638206455.180 [DAT](INFO): DAT read: Lowpower

2021-11-29T17:20:55.181Z,1638206455.181 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:23:06.494Z,1638206586.494 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T17:23:06.495Z,1638206586.495 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:23:06.495Z,1638206586.495 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:23:06.495Z,1638206586.495 [Default:CheckIn:D] Running Loop=1
2021-11-29T17:23:06.895Z,1638206586.895 [Default:CheckIn:D] Stopped
2021-11-29T17:23:06.896Z,1638206586.896 [Default:CheckIn:E] Running Loop=1
2021-11-29T17:23:07.302Z,1638206587.302 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 27.049575 min 
2021-11-29T17:23:07.304Z,1638206587.304 [Default:CheckIn:E] Stopped
2021-11-29T17:23:07.304Z,1638206587.304 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T17:23:07.304Z,1638206587.304 [Default:CheckIn] Stopped
2021-11-29T17:23:07.305Z,1638206587.305 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:23:07.305Z,1638206587.305 [Default:CheckIn](INFO): Running loop #6
2021-11-29T17:23:07.305Z,1638206587.305 [Default:CheckIn] Running Loop=6
2021-11-29T17:23:07.305Z,1638206587.305 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T17:23:07.305Z,1638206587.305 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T17:23:09.313Z,1638206589.313 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172308.00,A,3648.18004,N,12147.28048,W,0.350,199.23,291121,,,A*7E
2021-11-29T17:23:09.326Z,1638206589.326 [NAL9602](INFO): GPS fix at 20211129T172308: (36.803001, -121.788008)
2021-11-29T17:23:09.337Z,1638206589.337 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T17:23:09.337Z,1638206589.337 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T17:23:10.122Z,1638206590.122 [DAT](INFO): #Outgoing data=1
2021-11-29T17:23:10.123Z,1638206590.123 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T17:23:10.532Z,1638206590.532 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T17:23:10.938Z,1638206590.938 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T17:23:10.939Z,1638206590.939 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T17:23:10.940Z,1638206590.940 [DAT](INFO): commRate: 1200
2021-11-29T17:23:14.163Z,1638206594.163 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:22:37.3317

2021-11-29T17:23:14.163Z,1638206594.163 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T17:23:25.075Z,1638206605.075 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T17:23:25.075Z,1638206605.075 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T17:23:25.189Z,1638206605.189 [DAT](INFO): Sent 72 bytes from file Logs/20211129T161830/Courier0028.lzma.parts
2021-11-29T17:23:25.189Z,1638206605.189 [DAT](INFO): Packets left to send: 0
2021-11-29T17:23:25.192Z,1638206605.192 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T17:23:25.569Z,1638206605.569 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T17:23:25.569Z,1638206605.569 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T17:23:25.569Z,1638206605.569 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T17:23:40.889Z,1638206620.889 [NAL9602](INFO): SBD MO Status=2, MOMSN=30446, MT Status=2, MTMSN=0
2021-11-29T17:23:40.889Z,1638206620.889 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-11-29T17:24:11.592Z,1638206651.592 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T17:26:14.011Z,1638206774.011 [DAT](INFO): DAT read: Lowpower

2021-11-29T17:26:14.012Z,1638206774.012 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:28:26.163Z,1638206906.163 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T17:28:26.163Z,1638206906.163 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:28:26.163Z,1638206906.163 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:28:26.164Z,1638206906.164 [Default:CheckIn:D] Running Loop=1
2021-11-29T17:28:26.575Z,1638206906.575 [Default:CheckIn:D] Stopped
2021-11-29T17:28:26.575Z,1638206906.575 [Default:CheckIn:E] Running Loop=1
2021-11-29T17:28:26.939Z,1638206906.939 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.377566 min 
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn:E] Stopped
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn] Stopped
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn](INFO): Running loop #7
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn] Running Loop=7
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T17:28:26.940Z,1638206906.940 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T17:28:28.954Z,1638206908.954 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172828.00,A,3648.16566,N,12147.28071,W,0.214,199.23,291121,,,A*73
2021-11-29T17:28:28.957Z,1638206908.957 [NAL9602](INFO): GPS fix at 20211129T172828: (36.802761, -121.788012)
2021-11-29T17:28:28.969Z,1638206908.969 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T17:28:28.969Z,1638206908.969 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T17:28:29.762Z,1638206909.762 [DAT](INFO): #Outgoing data=1
2021-11-29T17:28:29.762Z,1638206909.762 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T17:28:30.161Z,1638206910.161 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T17:28:30.567Z,1638206910.567 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T17:28:30.568Z,1638206910.568 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T17:28:30.569Z,1638206910.569 [DAT](INFO): commRate: 1200
2021-11-29T17:28:33.420Z,1638206913.420 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:27:57.3324

2021-11-29T17:28:33.420Z,1638206913.420 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T17:28:45.123Z,1638206925.123 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T17:28:45.124Z,1638206925.124 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T17:28:45.231Z,1638206925.231 [DAT](INFO): Sent 72 bytes from file Logs/20211129T161830/Courier0031.lzma.parts
2021-11-29T17:28:45.231Z,1638206925.231 [DAT](INFO): Packets left to send: 0
2021-11-29T17:28:45.234Z,1638206925.234 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T17:28:45.651Z,1638206925.651 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T17:28:45.651Z,1638206925.651 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T17:28:45.651Z,1638206925.651 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T17:28:56.933Z,1638206936.933 [NAL9602](INFO): SBD MO Status=2, MOMSN=30446, MT Status=2, MTMSN=0
2021-11-29T17:28:56.933Z,1638206936.933 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2021-11-29T17:29:27.634Z,1638206967.634 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T17:31:33.691Z,1638207093.691 [DAT](INFO): DAT read: Lowpower

2021-11-29T17:31:33.691Z,1638207093.691 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:33:46.227Z,1638207226.227 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2021-11-29T17:33:46.230Z,1638207226.230 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:33:46.230Z,1638207226.230 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:33:46.231Z,1638207226.231 [Default:CheckIn:D] Running Loop=1
2021-11-29T17:33:46.623Z,1638207226.623 [Default:CheckIn:D] Stopped
2021-11-29T17:33:46.623Z,1638207226.623 [Default:CheckIn:E] Running Loop=1
2021-11-29T17:33:47.034Z,1638207227.034 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 37.711702 min 
2021-11-29T17:33:47.034Z,1638207227.034 [Default:CheckIn:E] Stopped
2021-11-29T17:33:47.035Z,1638207227.035 [Default:CheckIn](INFO): Completed Default:CheckIn
2021-11-29T17:33:47.035Z,1638207227.035 [Default:CheckIn] Stopped
2021-11-29T17:33:47.035Z,1638207227.035 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:33:47.035Z,1638207227.035 [Default:CheckIn](INFO): Running loop #8
2021-11-29T17:33:47.035Z,1638207227.035 [Default:CheckIn] Running Loop=8
2021-11-29T17:33:47.035Z,1638207227.035 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2021-11-29T17:33:47.035Z,1638207227.035 [Default:CheckIn:Read_GPS] Running Loop=1
2021-11-29T17:33:49.025Z,1638207229.025 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173348.00,A,3648.14118,N,12147.22702,W,0.097,56.41,291121,,,A*46
2021-11-29T17:33:49.028Z,1638207229.028 [NAL9602](INFO): GPS fix at 20211129T173348: (36.802353, -121.787117)
2021-11-29T17:33:49.079Z,1638207229.079 [Default:CheckIn:Read_GPS] Stopped
2021-11-29T17:33:49.079Z,1638207229.079 [Default:CheckIn:Read_Iridium] Running Loop=1
2021-11-29T17:33:49.851Z,1638207229.851 [DAT](INFO): #Outgoing data=1
2021-11-29T17:33:49.852Z,1638207229.852 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT
2021-11-29T17:33:50.237Z,1638207230.237 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY
2021-11-29T17:33:50.657Z,1638207230.657 [DAT](INFO): DAT read: UART Wakeup

2021-11-29T17:33:50.658Z,1638207230.658 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC

2021-11-29T17:33:50.659Z,1638207230.659 [DAT](INFO): commRate: 1200
2021-11-29T17:33:53.873Z,1638207233.873 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:33:17.3319

2021-11-29T17:33:53.874Z,1638207233.874 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING
2021-11-29T17:34:04.045Z,1638207244.045 [DAT](FAULT): Ack receipt timeout failure.
2021-11-29T17:34:04.045Z,1638207244.045 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED
2021-11-29T17:34:04.441Z,1638207244.441 [DAT](INFO): Sent 72 bytes from file Logs/20211129T161830/Courier0034.lzma.parts
2021-11-29T17:34:04.441Z,1638207244.441 [DAT](INFO): Packets left to send: 0
2021-11-29T17:34:04.444Z,1638207244.444 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER
2021-11-29T17:34:04.888Z,1638207244.888 [Default:CheckIn:Read_Iridium] Stopped
2021-11-29T17:34:04.888Z,1638207244.888 [Default:CheckIn:C.Wait] Running Loop=1
2021-11-29T17:34:04.888Z,1638207244.888 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2021-11-29T17:34:12.131Z,1638207252.131 [NAL9602](INFO): SBD MO Status=1, MOMSN=30446, MT Status=0, MTMSN=0
2021-11-29T17:34:12.191Z,1638207252.191 [NAL9602](INFO): Sent 72 bytes from file Logs/20211129T161830/Courier0034.lzma
2021-11-29T17:34:12.191Z,1638207252.191 [NAL9602](INFO): Packets left to send: 0
2021-11-29T17:34:42.824Z,1638207282.824 [NAL9602](INFO): Not Powering down - fast GPS
2021-11-29T17:36:53.518Z,1638207413.518 [DAT](INFO): DAT read: Lowpower

2021-11-29T17:36:53.518Z,1638207413.518 [DAT](INFO): unknown deviceResponse_: Lowpower

2021-11-29T17:37:31.184Z,1638207451.184 [CommandExec](IMPORTANT): got command restart system
2021-11-29T17:37:33.234Z,1638207453.234 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:33.235Z,1638207453.235 [CommandExec](INFO): Uninitializing the command executive.
2021-11-29T17:37:33.235Z,1638207453.235 [CommandExec](INFO): Uninitializing the command scheduler.
2021-11-29T17:37:33.235Z,1638207453.235 [CommandExec ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:33.306Z,1638207453.306 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-11-29T17:37:33.306Z,1638207453.306 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-11-29T17:37:33.307Z,1638207453.307 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:33.307Z,1638207453.307 [NavChartDb](INFO): Join timeout helper Thread ID is 9772
2021-11-29T17:37:33.459Z,1638207453.459 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:33.460Z,1638207453.460 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:33.466Z,1638207453.466 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2021-11-29T17:37:33.466Z,1638207453.466 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:33.467Z,1638207453.467 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9773
2021-11-29T17:37:33.807Z,1638207453.807 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:33.807Z,1638207453.807 [WetLabsBB2FL](INFO): Powering down
2021-11-29T17:37:33.808Z,1638207453.808 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:33.822Z,1638207453.822 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-11-29T17:37:33.822Z,1638207453.822 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:33.823Z,1638207453.823 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9774
2021-11-29T17:37:34.700Z,1638207454.700 [CTD_Seabird](INFO): Powering down
2021-11-29T17:37:34.714Z,1638207454.714 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:34.714Z,1638207454.714 [CTD_Seabird](INFO): Powering down
2021-11-29T17:37:34.726Z,1638207454.726 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:34.742Z,1638207454.742 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-11-29T17:37:34.742Z,1638207454.742 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:34.743Z,1638207454.743 [Radio_Surface](INFO): Join timeout helper Thread ID is 9775
2021-11-29T17:37:35.078Z,1638207455.078 [Radio_Surface](INFO): Powering down
2021-11-29T17:37:35.079Z,1638207455.079 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:35.080Z,1638207455.080 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.086Z,1638207455.086 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-11-29T17:37:35.086Z,1638207455.086 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.087Z,1638207455.087 [Onboard](INFO): Join timeout helper Thread ID is 9776
2021-11-29T17:37:35.570Z,1638207455.570 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:35.571Z,1638207455.571 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.575Z,1638207455.575 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-11-29T17:37:35.575Z,1638207455.575 [logger ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.576Z,1638207455.576 [logger](INFO): Join timeout helper Thread ID is 9777
2021-11-29T17:37:35.590Z,1638207455.590 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:35.591Z,1638207455.591 [logger ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.595Z,1638207455.595 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-11-29T17:37:35.595Z,1638207455.595 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.595Z,1638207455.595 [CommandLine](INFO): Join timeout helper Thread ID is 9778
2021-11-29T17:37:35.674Z,1638207455.674 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:35.675Z,1638207455.675 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.695Z,1638207455.695 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2021-11-29T17:37:35.695Z,1638207455.695 [CommandExec ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.696Z,1638207455.696 [CommandExec](INFO): Join timeout helper Thread ID is 9779
2021-11-29T17:37:35.697Z,1638207455.697 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-11-29T17:37:35.697Z,1638207455.697 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:35.697Z,1638207455.697 [controlThread](INFO): Join timeout helper Thread ID is 9780
2021-11-29T17:37:35.718Z,1638207455.718 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-11-29T17:37:35.719Z,1638207455.719 [controlThread](DEBUG): Uninitializing ControlThread
2021-11-29T17:37:35.719Z,1638207455.719 [AHRS_M2](INFO): Powering down
2021-11-29T17:37:35.791Z,1638207455.791 [NAL9602](INFO): Powering down
2021-11-29T17:37:35.793Z,1638207455.793 [DAT](INFO): Powering down
2021-11-29T17:37:35.912Z,1638207455.912 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-11-29T17:37:35.913Z,1638207455.913 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-11-29T17:37:35.914Z,1638207455.914 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-11-29T17:37:35.914Z,1638207455.914 [MissionManager](INFO): Uninitializing Mission Default
2021-11-29T17:37:35.915Z,1638207455.915 [Default] Stopped
2021-11-29T17:37:35.915Z,1638207455.915 [Default](DEBUG): Aggregate::uninitialize Default
2021-11-29T17:37:35.915Z,1638207455.915 [Default:B.GoToSurface] Stopped
2021-11-29T17:37:35.915Z,1638207455.915 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2021-11-29T17:37:35.915Z,1638207455.915 [Default:CheckIn] Stopped
2021-11-29T17:37:35.915Z,1638207455.915 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2021-11-29T17:37:35.915Z,1638207455.915 [Default:CheckIn:C.Wait] Stopped
2021-11-29T17:37:35.915Z,1638207455.915 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2021-11-29T17:37:35.919Z,1638207455.919 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-11-29T17:37:35.919Z,1638207455.919 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-11-29T17:37:35.919Z,1638207455.919 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-11-29T17:37:35.920Z,1638207455.920 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-11-29T17:37:35.920Z,1638207455.920 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-11-29T17:37:35.920Z,1638207455.920 [BuoyancyServo](INFO): Powering down
2021-11-29T17:37:35.934Z,1638207455.934 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-11-29T17:37:35.934Z,1638207455.934 [ElevatorServo](INFO): Powering down
2021-11-29T17:37:35.935Z,1638207455.935 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-11-29T17:37:35.936Z,1638207455.936 [MassServo](INFO): Powering down
2021-11-29T17:37:35.937Z,1638207455.937 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-11-29T17:37:35.937Z,1638207455.937 [RudderServo](INFO): Powering down
2021-11-29T17:37:35.938Z,1638207455.938 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2021-11-29T17:37:35.938Z,1638207455.938 [ThrusterServo](INFO): Powering down
2021-11-29T17:37:35.939Z,1638207455.939 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-11-29T17:37:35.939Z,1638207455.939 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-11-29T17:37:35.940Z,1638207455.940 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-11-29T17:37:35.940Z,1638207455.940 [CBIT](DEBUG): Powering off loads.
2021-11-29T17:37:35.954Z,1638207455.954 [CBIT](DEBUG): Disabling WDT.
2021-11-29T17:37:35.966Z,1638207455.966 [CBIT](DEBUG): Opening all GF detection circuits.
2021-11-29T17:37:35.967Z,1638207455.967 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:36.017Z,1638207456.017 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:36.020Z,1638207456.020 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:36.092Z,1638207456.092 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:36.096Z,1638207456.096 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:36.138Z,1638207456.138 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-11-29T17:37:36.212Z,1638207456.212 [logger ThreadHandler](INFO): Thread cancelled.