2023-05-16T18:53:22.928Z,1684263202.928 [Supervisor](DEBUG): Initializing supervisor.
2023-05-16T18:53:22.932Z,1684263202.932 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-05-16T18:53:22.933Z,1684263202.933 [SyncHandler](INFO): Protected caller Thread ID is 8234
2023-05-16T18:53:22.933Z,1684263202.933 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-05-16T18:53:22.934Z,1684263202.934 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-05-16T18:53:22.935Z,1684263202.935 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8235
2023-05-16T18:53:22.939Z,1684263202.939 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-05-16T18:53:22.955Z,1684263202.955 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-05-16T18:53:22.956Z,1684263202.956 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-05-16T18:53:22.957Z,1684263202.957 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8236
2023-05-16T18:53:22.961Z,1684263202.961 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-05-16T18:53:22.962Z,1684263202.962 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-05-16T18:53:22.962Z,1684263202.962 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8237
2023-05-16T18:53:22.964Z,1684263202.964 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-05-16T18:53:22.965Z,1684263202.965 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-05-16T18:53:22.965Z,1684263202.965 [logger ThreadHandler](INFO): Protected caller Thread ID is 8238
2023-05-16T18:53:22.969Z,1684263202.969 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-05-16T18:53:22.969Z,1684263202.969 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-05-16T18:53:22.971Z,1684263202.971 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-05-16T18:53:23.177Z,1684263203.177 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-05-16T18:53:23.178Z,1684263203.178 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-05-16T18:53:23.282Z,1684263203.282 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-05-16T18:53:23.283Z,1684263203.283 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-05-16T18:53:23.377Z,1684263203.377 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-05-16T18:53:23.378Z,1684263203.378 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-05-16T18:53:23.819Z,1684263203.819 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-05-16T18:53:23.820Z,1684263203.820 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-05-16T18:53:24.154Z,1684263204.154 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-05-16T18:53:24.154Z,1684263204.154 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-05-16T18:53:24.475Z,1684263204.475 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-05-16T18:53:24.476Z,1684263204.476 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-05-16T18:53:24.653Z,1684263204.653 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-05-16T18:53:24.653Z,1684263204.653 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-05-16T18:53:24.732Z,1684263204.732 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-05-16T18:53:24.814Z,1684263204.814 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-05-16T18:53:25.190Z,1684263205.190 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-05-16T18:53:25.190Z,1684263205.190 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-05-16T18:53:25.455Z,1684263205.455 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-05-16T18:53:25.455Z,1684263205.455 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-05-16T18:53:25.935Z,1684263205.935 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-05-16T18:53:25.936Z,1684263205.936 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-05-16T18:53:26.141Z,1684263206.141 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-05-16T18:53:26.141Z,1684263206.141 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-05-16T18:53:26.373Z,1684263206.373 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-05-16T18:53:26.374Z,1684263206.374 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-05-16T18:53:26.510Z,1684263206.510 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-05-16T18:53:26.511Z,1684263206.511 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-05-16T18:53:27.269Z,1684263207.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-05-16T18:53:27.271Z,1684263207.271 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2023-05-16T18:53:27.272Z,1684263207.272 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2023-05-16T18:53:27.356Z,1684263207.356 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2023-05-16T18:53:27.529Z,1684263207.529 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2023-05-16T18:53:27.825Z,1684263207.825 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-05-16T18:53:27.826Z,1684263207.826 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2023-05-16T18:53:27.000Z,1684263208.000 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2023-05-16T18:53:28.099Z,1684263208.099 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2023-05-16T18:53:28.346Z,1684263208.346 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2023-05-16T18:53:28.484Z,1684263208.484 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2023-05-16T18:53:28.810Z,1684263208.810 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2023-05-16T18:53:29.076Z,1684263209.076 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2023-05-16T18:53:29.174Z,1684263209.174 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2023-05-16T18:53:29.330Z,1684263209.330 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-05-16T18:53:29.344Z,1684263209.344 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-05-16T18:53:29.395Z,1684263209.395 [DepthRateCalculator] Loaded
2023-05-16T18:53:29.395Z,1684263209.395 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-05-16T18:53:29.400Z,1684263209.400 [PitchRateCalculator] Loaded
2023-05-16T18:53:29.400Z,1684263209.400 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-05-16T18:53:29.410Z,1684263209.410 [SpeedCalculator] Loaded
2023-05-16T18:53:29.410Z,1684263209.410 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-05-16T18:53:29.425Z,1684263209.425 [VerticalHomogeneityIndexCalculator] Loaded
2023-05-16T18:53:29.425Z,1684263209.425 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2023-05-16T18:53:29.430Z,1684263209.430 [YawRateCalculator] Loaded
2023-05-16T18:53:29.430Z,1684263209.430 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-05-16T18:53:29.451Z,1684263209.451 [ElevatorOffsetCalculator] Loaded
2023-05-16T18:53:29.451Z,1684263209.451 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-05-16T18:53:29.452Z,1684263209.452 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-05-16T18:53:29.452Z,1684263209.452 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-05-16T18:53:29.479Z,1684263209.479 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-05-16T18:53:29.479Z,1684263209.479 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-05-16T18:53:29.489Z,1684263209.489 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-05-16T18:53:29.490Z,1684263209.490 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-05-16T18:53:29.897Z,1684263209.897 [AHRS_M2] Loaded
2023-05-16T18:53:29.897Z,1684263209.897 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-05-16T18:53:29.932Z,1684263209.932 [BackseatComponent] Loaded
2023-05-16T18:53:29.932Z,1684263209.932 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-05-16T18:53:29.933Z,1684263209.933 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408474E0
2023-05-16T18:53:29.933Z,1684263209.933 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 8320
2023-05-16T18:53:29.936Z,1684263209.936 [LcmUniversalReporter] Loaded
2023-05-16T18:53:29.936Z,1684263209.936 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-05-16T18:53:30.723Z,1684263210.723 [BPC1] Loaded
2023-05-16T18:53:30.723Z,1684263210.723 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-05-16T18:53:30.794Z,1684263210.794 [DataOverHttps] Loaded
2023-05-16T18:53:30.794Z,1684263210.794 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-05-16T18:53:30.795Z,1684263210.795 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408774E0
2023-05-16T18:53:30.795Z,1684263210.795 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8321
2023-05-16T18:53:30.816Z,1684263210.816 [Depth_Keller] Loaded
2023-05-16T18:53:30.816Z,1684263210.816 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-05-16T18:53:30.821Z,1684263210.821 [DropWeight] Loaded
2023-05-16T18:53:30.821Z,1684263210.821 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-05-16T18:53:30.882Z,1684263210.882 [NAL9602] Loaded
2023-05-16T18:53:30.882Z,1684263210.882 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-05-16T18:53:30.911Z,1684263210.911 [Onboard] Loaded
2023-05-16T18:53:30.911Z,1684263210.911 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-05-16T18:53:30.912Z,1684263210.912 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408A74E0
2023-05-16T18:53:30.912Z,1684263210.912 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8322
2023-05-16T18:53:30.918Z,1684263210.918 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2023-05-16T18:53:30.929Z,1684263210.929 [PowerOnly] Loaded
2023-05-16T18:53:30.929Z,1684263210.929 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2023-05-16T18:53:30.941Z,1684263210.941 [Power24vConverter] Loaded
2023-05-16T18:53:30.941Z,1684263210.941 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-05-16T18:53:30.954Z,1684263210.954 [Radio_Surface] Loaded
2023-05-16T18:53:30.955Z,1684263210.955 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-05-16T18:53:30.956Z,1684263210.956 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408D74E0
2023-05-16T18:53:30.956Z,1684263210.956 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8323
2023-05-16T18:53:30.978Z,1684263210.978 [Waterlinked] Loaded
2023-05-16T18:53:30.979Z,1684263210.979 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2023-05-16T18:53:30.979Z,1684263210.979 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-05-16T18:53:30.979Z,1684263210.979 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-05-16T18:53:31.086Z,1684263211.086 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-05-16T18:53:31.087Z,1684263211.087 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-05-16T18:53:31.127Z,1684263211.127 [DeadReckonUsingSpeedCalculator] Loaded
2023-05-16T18:53:31.127Z,1684263211.127 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-05-16T18:53:31.140Z,1684263211.140 [NavChart] Loaded
2023-05-16T18:53:31.140Z,1684263211.140 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-05-16T18:53:31.146Z,1684263211.146 [UniversalFixResidualReporter] Loaded
2023-05-16T18:53:31.146Z,1684263211.146 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-05-16T18:53:31.147Z,1684263211.147 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-05-16T18:53:31.147Z,1684263211.147 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-05-16T18:53:31.284Z,1684263211.284 [SBIT](DEBUG): Construct Startup Built In Test.
2023-05-16T18:53:31.297Z,1684263211.297 [SBIT] Loaded
2023-05-16T18:53:31.297Z,1684263211.297 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-05-16T18:53:31.300Z,1684263211.300 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-05-16T18:53:31.312Z,1684263211.312 [IBIT] Loaded
2023-05-16T18:53:31.313Z,1684263211.313 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-05-16T18:53:31.318Z,1684263211.318 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-05-16T18:53:31.418Z,1684263211.418 [CBIT] Loaded
2023-05-16T18:53:31.418Z,1684263211.418 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-05-16T18:53:31.418Z,1684263211.418 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-05-16T18:53:31.419Z,1684263211.419 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-05-16T18:53:31.584Z,1684263211.584 [CTD_Seabird] Loaded
2023-05-16T18:53:31.584Z,1684263211.584 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-05-16T18:53:31.585Z,1684263211.585 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0
2023-05-16T18:53:31.586Z,1684263211.586 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8324
2023-05-16T18:53:31.605Z,1684263211.605 [PAR_Licor] Loaded
2023-05-16T18:53:31.606Z,1684263211.606 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-05-16T18:53:31.635Z,1684263211.635 [WetLabsBB2FL] Loaded
2023-05-16T18:53:31.636Z,1684263211.636 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-05-16T18:53:31.637Z,1684263211.637 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A0B4E0
2023-05-16T18:53:31.637Z,1684263211.637 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8325
2023-05-16T18:53:31.638Z,1684263211.638 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-05-16T18:53:31.639Z,1684263211.639 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-05-16T18:53:31.770Z,1684263211.770 [BuoyancyServo] Loaded
2023-05-16T18:53:31.770Z,1684263211.770 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-05-16T18:53:31.791Z,1684263211.791 [ElevatorServo] Loaded
2023-05-16T18:53:31.791Z,1684263211.791 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-05-16T18:53:31.813Z,1684263211.813 [MassServo] Loaded
2023-05-16T18:53:31.814Z,1684263211.814 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-05-16T18:53:31.833Z,1684263211.833 [RudderServo] Loaded
2023-05-16T18:53:31.834Z,1684263211.834 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-05-16T18:53:31.849Z,1684263211.849 [ThrusterHE] Loaded
2023-05-16T18:53:31.849Z,1684263211.849 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-05-16T18:53:31.850Z,1684263211.850 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-05-16T18:53:31.850Z,1684263211.850 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-05-16T18:53:31.899Z,1684263211.899 [VerticalControl](DEBUG): Construct VerticalControl.
2023-05-16T18:53:31.948Z,1684263211.948 [VerticalControl] Loaded
2023-05-16T18:53:31.949Z,1684263211.949 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-05-16T18:53:31.951Z,1684263211.951 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-05-16T18:53:31.987Z,1684263211.987 [HorizontalControl] Loaded
2023-05-16T18:53:31.988Z,1684263211.988 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-05-16T18:53:31.990Z,1684263211.990 [SpeedControl](DEBUG): Construct SpeedControl.
2023-05-16T18:53:31.992Z,1684263211.992 [SpeedControl] Loaded
2023-05-16T18:53:31.992Z,1684263211.992 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-05-16T18:53:31.995Z,1684263211.995 [LoopControl](DEBUG): Construct LoopControl.
2023-05-16T18:53:31.995Z,1684263211.995 [LoopControl] Loaded
2023-05-16T18:53:31.996Z,1684263211.996 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-05-16T18:53:31.996Z,1684263211.996 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-05-16T18:53:31.996Z,1684263211.996 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-05-16T18:53:32.094Z,1684263212.094 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-05-16T18:53:32.095Z,1684263212.095 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-05-16T18:53:32.240Z,1684263212.240 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-05-16T18:53:32.240Z,1684263212.240 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-05-16T18:53:32.542Z,1684263212.542 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-05-16T18:53:32.542Z,1684263212.542 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-05-16T18:53:32.611Z,1684263212.611 [StratificationFrontDetector](INFO): thresholdVTHI set to: 0.399988 degC
2023-05-16T18:53:32.611Z,1684263212.611 [StratificationFrontDetector](DEBUG): (re)initializing
2023-05-16T18:53:32.612Z,1684263212.612 [StratificationFrontDetector] Loaded
2023-05-16T18:53:32.612Z,1684263212.612 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2023-05-16T18:53:32.612Z,1684263212.612 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-05-16T18:53:32.618Z,1684263212.618 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-05-16T18:53:32.621Z,1684263212.621 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-05-16T18:53:32.632Z,1684263212.632 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-05-16T18:53:32.633Z,1684263212.633 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BB74E0
2023-05-16T18:53:32.633Z,1684263212.633 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8326
2023-05-16T18:53:32.638Z,1684263212.638 [Supervisor](INFO): Main Thread ID is 8233
2023-05-16T18:53:32.638Z,1684263212.638 [Supervisor](DEBUG): Running supervisor.
2023-05-16T18:53:32.638Z,1684263212.638 [CommandExec ThreadHandler](INFO): Handler Thread ID is 8327
2023-05-16T18:53:32.639Z,1684263212.639 [CommandExec](INFO): Initializing the command executive.
2023-05-16T18:53:32.640Z,1684263212.640 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8328
2023-05-16T18:53:32.643Z,1684263212.643 [controlThread ThreadHandler](INFO): Handler Thread ID is 8329
2023-05-16T18:53:32.643Z,1684263212.643 [controlThread](DEBUG): Initializing ControlThread
2023-05-16T18:53:32.644Z,1684263212.644 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-05-16T18:53:32.644Z,1684263212.644 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-05-16T18:53:32.645Z,1684263212.645 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-05-16T18:53:32.645Z,1684263212.645 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2023-05-16T18:53:32.646Z,1684263212.646 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-05-16T18:53:32.646Z,1684263212.646 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-05-16T18:53:32.652Z,1684263212.652 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:53:32.652Z,1684263212.652 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-05-16T18:53:32.653Z,1684263212.653 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-05-16T18:53:32.653Z,1684263212.653 [SBIT](INFO): Initialize SBIT Component.
2023-05-16T18:53:32.654Z,1684263212.654 [SBIT](IMPORTANT): git: 2023-05-11-1-g0756d5a45
2023-05-16T18:53:32.654Z,1684263212.654 [SBIT](INFO): git hash: 0756d5a45b55fc759b5de63a78c860713c4b2bf5
2023-05-16T18:53:32.654Z,1684263212.654 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-05-16T18:53:32.655Z,1684263212.655 [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
2023-05-16T18:53:32.656Z,1684263212.656 [SBIT](INFO): Beginning SBIT in 83.000000 seconds.
2023-05-16T18:53:32.657Z,1684263212.657 [IBIT](INFO): Initialize IBIT Component.
2023-05-16T18:53:32.658Z,1684263212.658 [CBIT](DEBUG): Initialize CBIT Component.
2023-05-16T18:53:32.659Z,1684263212.659 [logger ThreadHandler](INFO): Handler Thread ID is 8330
2023-05-16T18:53:32.669Z,1684263212.669 [CBIT](DEBUG): Initialized mux pins.
2023-05-16T18:53:32.669Z,1684263212.669 [CBIT](DEBUG): Initializing the watchdog timer.
2023-05-16T18:53:32.678Z,1684263212.678 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8331
2023-05-16T18:53:32.690Z,1684263212.690 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8332
2023-05-16T18:53:32.691Z,1684263212.691 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-05-16T18:53:32.693Z,1684263212.693 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-05-16T18:53:32.694Z,1684263212.694 [CBIT](DEBUG): Initializing heartbeat.
2023-05-16T18:53:32.702Z,1684263212.702 [Onboard ThreadHandler](INFO): Handler Thread ID is 8333
2023-05-16T18:53:32.719Z,1684263212.719 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8334
2023-05-16T18:53:32.742Z,1684263212.742 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8335
2023-05-16T18:53:32.743Z,1684263212.743 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-05-16T18:53:32.747Z,1684263212.747 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8337
2023-05-16T18:53:32.750Z,1684263212.750 [WetLabsBB2FL](INFO): Powering up
2023-05-16T18:53:32.751Z,1684263212.751 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8339
2023-05-16T18:53:32.753Z,1684263212.753 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-05-16T18:53:32.754Z,1684263212.754 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-05-16T18:53:32.754Z,1684263212.754 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-05-16T18:53:32.754Z,1684263212.754 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-05-16T18:53:32.754Z,1684263212.754 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-05-16T18:53:32.754Z,1684263212.754 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-05-16T18:53:32.754Z,1684263212.754 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-05-16T18:53:32.754Z,1684263212.754 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-05-16T18:53:32.765Z,1684263212.765 [CBIT](DEBUG): Deactivating GF circuits.
2023-05-16T18:53:32.765Z,1684263212.765 [CBIT](DEBUG): Deactivating emergency mode.
2023-05-16T18:53:32.805Z,1684263212.805 [CBIT](DEBUG): Backplane powered.
2023-05-16T18:53:32.815Z,1684263212.815 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-05-16T18:53:32.817Z,1684263212.817 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-05-16T18:53:32.818Z,1684263212.818 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-05-16T18:53:32.818Z,1684263212.818 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-05-16T18:53:32.819Z,1684263212.819 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-05-16T18:53:32.877Z,1684263212.877 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T18:53:32.916Z,1684263212.916 [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>


2023-05-16T18:53:32.916Z,1684263212.916 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-05-16T18:53:32.975Z,1684263212.975 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-05-16T18:53:32.976Z,1684263212.976 [Default:A.Wait](DEBUG): Construct Wait.
2023-05-16T18:53:32.993Z,1684263212.993 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T18:53:33.026Z,1684263213.026 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-05-16T18:53:33.028Z,1684263213.028 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-05-16T18:53:33.042Z,1684263213.042 [Default:E.Execute](DEBUG): Construct Execute.
2023-05-16T18:53:33.059Z,1684263213.059 [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="P4H">
                <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>


2023-05-16T18:53:33.064Z,1684263213.064 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-05-16T18:53:33.083Z,1684263213.083 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-05-16T18:53:33.125Z,1684263213.125 [Radio_Surface](INFO): Powering up
2023-05-16T18:53:33.182Z,1684263213.182 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1629.131348 decibar, 0.000000 m
2023-05-16T18:53:33.184Z,1684263213.184 [Power24vConverter](INFO): Powering up.
2023-05-16T18:53:33.203Z,1684263213.203 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-05-16T18:53:33.235Z,1684263213.235 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:53:33.242Z,1684263213.242 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-05-16T18:53:33.243Z,1684263213.243 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:53:33.250Z,1684263213.250 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-05-16T18:53:33.251Z,1684263213.251 [MassServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:53:33.257Z,1684263213.257 [MassServo](DEBUG): Initializing MassServo.
2023-05-16T18:53:33.258Z,1684263213.258 [RudderServo](DEBUG): Initializing EZServoServo.
2023-05-16T18:53:33.266Z,1684263213.266 [RudderServo](DEBUG): Initializing RudderServo.
2023-05-16T18:53:33.266Z,1684263213.266 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-05-16T18:53:33.274Z,1684263213.274 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-05-16T18:53:35.361Z,1684263215.361 [WetLabsBB2FL](INFO): Powering down
2023-05-16T18:53:38.970Z,1684263218.970 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-05-16T18:53:39.774Z,1684263219.774 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2023-05-16T18:53:43.292Z,1684263223.292 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004723
2023-05-16T18:54:00.955Z,1684263240.955 [NAL9602](INFO): Powering up NAL9602
2023-05-16T18:54:07.098Z,1684263247.098 [Waterlinked](INFO): Powering down
2023-05-16T18:54:11.860Z,1684263251.860 [NAL9602](INFO): NAL9602 initialized
2023-05-16T18:54:45.446Z,1684263285.446 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:54:56.317Z,1684263296.317 [SBIT](IMPORTANT): Beginning Startup BIT
2023-05-16T18:54:56.321Z,1684263296.321 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-16T18:55:07.291Z,1684263307.291 [CBIT](IMPORTANT): Low side ground fault detected
mA:
CHAN A0 (Batt): 0.813752
CHAN A1 (24V): 0.767726
CHAN A2 (12V): 0.660708
CHAN A3 (5V): 0.118084
CHAN B0 (3.3V): 0.048646
CHAN B1 (3.15aV): 0.049325
CHAN B2 (3.15bV): 0.050084
CHAN B3 (GND): -0.030125
OPEN: 0.011924
Full Scale: +/- 1 mA
2023-05-16T18:55:38.779Z,1684263338.779 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:55:50.460Z,1684263350.460 [SBIT](IMPORTANT): SBIT PASSED
2023-05-16T18:55:50.461Z,1684263350.461 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-05-16T18:55:50.462Z,1684263350.462 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;

2023-05-16T18:55:50.462Z,1684263350.462 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute;

2023-05-16T18:55:50.462Z,1684263350.462 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_salinity_homogeneity_index 0.050000 practical_salinity_unit;

2023-05-16T18:55:50.462Z,1684263350.462 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_temperature_homogeneity_index 0.050000 celsius;

2023-05-16T18:55:50.462Z,1684263350.462 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 100.000000 gigabyte;

2023-05-16T18:55:50.462Z,1684263350.462 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 300.000000 count_per_second;

2023-05-16T18:55:50.462Z,1684263350.462 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_shape 10.000000 count_per_second;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_slope 0.200000 count_per_millimeter;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=281.701195 cubic_centimeter;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): VerticalControl.massDefault=15.762392 millimeter;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=20 meter;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=30 meter;

2023-05-16T18:55:50.463Z,1684263350.463 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.loadAtStartup=1 bool;

2023-05-16T18:55:50.856Z,1684263350.856 [MissionManager](IMPORTANT): Started mission Startup
2023-05-16T18:55:50.857Z,1684263350.857 [Startup] Running Loop=1
2023-05-16T18:55:50.873Z,1684263350.873 [Startup](DEBUG): Aggregate::initialize Startup
2023-05-16T18:55:50.873Z,1684263350.873 [Startup:A.GoToSurface] Running Loop=1
2023-05-16T18:55:50.873Z,1684263350.873 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T18:55:50.874Z,1684263350.874 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T18:55:50.874Z,1684263350.874 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T18:55:50.875Z,1684263350.875 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T18:55:50.875Z,1684263350.875 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T18:55:50.875Z,1684263350.875 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T18:55:50.877Z,1684263350.877 [Startup:StartupSatComms] Running Loop=1
2023-05-16T18:55:50.877Z,1684263350.877 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-05-16T18:55:50.882Z,1684263350.882 [Startup:StartupSatComms:A] Running Loop=1
2023-05-16T18:55:51.257Z,1684263351.257 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-05-16T18:55:52.108Z,1684263352.108 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2023-05-16T18:56:32.910Z,1684263392.910 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-05-16T18:56:32.910Z,1684263392.910 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:56:32.911Z,1684263392.911 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2023-05-16T18:56:32.911Z,1684263392.911 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:56:32.959Z,1684263392.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:56:32.959Z,1684263392.959 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:56:33.331Z,1684263393.331 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:56:33.331Z,1684263393.331 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-05-16T18:56:33.332Z,1684263393.332 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:56:33.332Z,1684263393.332 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2023-05-16T18:56:33.699Z,1684263393.699 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:56:39.926Z,1684263399.926 [CommandExec](IMPORTANT): got command gfscan
2023-05-16T18:56:40.147Z,1684263400.147 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-16T18:56:51.048Z,1684263411.048 [Startup:StartupSatComms:A](INFO): Timed out from 2023-05-16T18:55:50.9Z
2023-05-16T18:56:51.048Z,1684263411.048 [Startup:StartupSatComms:A] Stopped
2023-05-16T18:56:51.048Z,1684263411.048 [Startup:StartupSatComms:B] Running Loop=1
2023-05-16T18:56:51.083Z,1684263411.083 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.818429
CHAN A1 (24V): 0.768437
CHAN A2 (12V): 0.650434
CHAN A3 (5V): 0.115056
CHAN B0 (3.3V): 0.046112
CHAN B1 (3.15aV): 0.046851
CHAN B2 (3.15bV): 0.047485
CHAN B3 (GND): -0.029795
OPEN: 0.012233
Full Scale: +/- 1 mA
2023-05-16T18:56:51.464Z,1684263411.464 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-16T18:56:58.637Z,1684263418.637 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230516T181101/Courier0013.lzma
2023-05-16T18:56:59.639Z,1684263419.639 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Courier0013.lzma.bak
2023-05-16T18:56:59.639Z,1684263419.639 [DataOverHttps](INFO): SBD MOMSN=18316907
2023-05-16T18:57:15.221Z,1684263435.221 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230516T185322/Courier0000.lzma
2023-05-16T18:57:16.223Z,1684263436.223 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Courier0000.lzma.bak
2023-05-16T18:57:16.223Z,1684263436.223 [DataOverHttps](INFO): SBD MOMSN=18316921
2023-05-16T18:57:31.769Z,1684263451.769 [DataOverHttps](INFO): Sending 221 bytes from file Logs/20230516T181101/Express0014.lzma
2023-05-16T18:57:32.771Z,1684263452.771 [DataOverHttps](INFO): Moved sent file to Logs/20230516T181101/Express0014.lzma.bak
2023-05-16T18:57:32.771Z,1684263452.771 [DataOverHttps](INFO): SBD MOMSN=18316924
2023-05-16T18:57:51.244Z,1684263471.244 [Startup:StartupSatComms:B](INFO): Timed out from 2023-05-16T18:56:51.0Z
2023-05-16T18:57:51.244Z,1684263471.244 [Startup:StartupSatComms:B] Stopped
2023-05-16T18:57:51.244Z,1684263471.244 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-05-16T18:57:51.244Z,1684263471.244 [Startup:StartupSatComms] Stopped
2023-05-16T18:57:51.245Z,1684263471.245 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-05-16T18:57:51.266Z,1684263471.266 [Startup](INFO): Completed Startup
2023-05-16T18:57:51.266Z,1684263471.266 [MissionManager](INFO): Startup is completed.
2023-05-16T18:57:51.266Z,1684263471.266 [MissionManager](INFO): Uninitializing Mission Startup
2023-05-16T18:57:51.266Z,1684263471.266 [Startup] Stopped
2023-05-16T18:57:51.266Z,1684263471.266 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-05-16T18:57:51.266Z,1684263471.266 [Startup:A.GoToSurface] Stopped
2023-05-16T18:57:51.266Z,1684263471.266 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T18:57:51.648Z,1684263471.648 [MissionManager](IMPORTANT): Started mission Default
2023-05-16T18:57:51.649Z,1684263471.649 [Default] Running Loop=1
2023-05-16T18:57:51.649Z,1684263471.649 [Default](DEBUG): Aggregate::initialize Default
2023-05-16T18:57:51.649Z,1684263471.649 [Default:B.GoToSurface] Running Loop=1
2023-05-16T18:57:51.649Z,1684263471.649 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T18:57:51.649Z,1684263471.649 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T18:57:51.650Z,1684263471.650 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T18:57:51.650Z,1684263471.650 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T18:57:51.650Z,1684263471.650 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T18:57:51.651Z,1684263471.651 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T18:57:51.651Z,1684263471.651 [Default:A.Wait] Running Loop=1
2023-05-16T18:57:51.651Z,1684263471.651 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-05-16T18:58:05.009Z,1684263485.009 [Default:A.Wait](INFO): Done Waiting.
2023-05-16T18:58:05.009Z,1684263485.009 [Default:A.Wait] Stopped
2023-05-16T18:58:05.009Z,1684263485.009 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T18:58:05.419Z,1684263485.419 [Default:CheckIn] Running Loop=1
2023-05-16T18:58:05.419Z,1684263485.419 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-05-16T18:58:05.419Z,1684263485.419 [Default:CheckIn:Read_GPS] Running Loop=1
2023-05-16T18:58:05.814Z,1684263485.814 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-05-16T18:58:33.178Z,1684263513.178 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.407196
2023-05-16T18:59:11.365Z,1684263551.365 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T18:59:15.260Z,1684263555.260 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-05-16T18:59:33.858Z,1684263573.858 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-05-16T18:59:33.858Z,1684263573.858 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T18:59:33.859Z,1684263573.859 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2023-05-16T18:59:33.859Z,1684263573.859 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T18:59:33.895Z,1684263573.895 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T18:59:33.895Z,1684263573.895 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T18:59:34.273Z,1684263574.273 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T18:59:34.273Z,1684263574.273 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-05-16T18:59:34.274Z,1684263574.274 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T18:59:34.274Z,1684263574.274 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2023-05-16T18:59:34.667Z,1684263574.667 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T18:59:46.505Z,1684263586.505 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:00:21.650Z,1684263621.650 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:00:56.798Z,1684263656.798 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:01:31.946Z,1684263691.946 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:02:03.734Z,1684263723.734 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2023-05-16T19:02:03.737Z,1684263723.737 [BPC1](INFO): Received data from all battery sticks.
2023-05-16T19:02:07.086Z,1684263727.086 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:02:34.855Z,1684263754.855 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-05-16T19:02:34.855Z,1684263754.855 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T19:02:34.856Z,1684263754.856 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2023-05-16T19:02:34.856Z,1684263754.856 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T19:02:34.867Z,1684263754.867 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T19:02:34.867Z,1684263754.867 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T19:02:35.283Z,1684263755.283 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T19:02:35.283Z,1684263755.283 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-05-16T19:02:35.284Z,1684263755.284 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T19:02:35.284Z,1684263755.284 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2023-05-16T19:02:35.674Z,1684263755.674 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T19:02:42.234Z,1684263762.234 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:03:05.563Z,1684263785.563 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-05-16T18:58:05.4Z
2023-05-16T19:03:05.563Z,1684263785.563 [Default:CheckIn:Read_GPS] Stopped
2023-05-16T19:03:05.563Z,1684263785.563 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-05-16T19:03:05.960Z,1684263785.960 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-16T19:03:17.374Z,1684263797.374 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:03:37.463Z,1684263817.463 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response. 
2023-05-16T19:03:37.537Z,1684263817.537 [NAL9602](ERROR): received: 
+CSQ:0

OK
2023-05-16T19:03:52.513Z,1684263832.513 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:04:08.182Z,1684263848.182 [Power24vConverter](INFO): Powering down.
2023-05-16T19:04:15.440Z,1684263855.440 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-16T19:04:15.440Z,1684263855.440 [NAL9602] Data Fault, FailCount= 1
2023-05-16T19:04:15.440Z,1684263855.440 [NAL9602](ERROR): Data Fault
2023-05-16T19:04:15.462Z,1684263855.462 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-16T19:04:15.839Z,1684263855.839 [NAL9602](INFO): Powering down
2023-05-16T19:04:16.669Z,1684263856.669 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-16T19:04:16.669Z,1684263856.669 [NAL9602] No Fault, FailCount= 1
2023-05-16T19:04:27.653Z,1684263867.653 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:04:46.149Z,1684263886.149 [NAL9602](INFO): Powering up NAL9602
2023-05-16T19:04:57.051Z,1684263897.051 [NAL9602](INFO): NAL9602 initialized
2023-05-16T19:05:02.802Z,1684263902.802 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:05:35.839Z,1684263935.839 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-05-16T19:05:35.839Z,1684263935.839 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T19:05:35.840Z,1684263935.840 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2023-05-16T19:05:35.840Z,1684263935.840 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T19:05:35.874Z,1684263935.874 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T19:05:35.875Z,1684263935.875 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T19:05:36.252Z,1684263936.252 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T19:05:36.253Z,1684263936.253 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-05-16T19:05:36.253Z,1684263936.253 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T19:05:36.253Z,1684263936.253 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2023-05-16T19:05:36.652Z,1684263936.652 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T19:05:37.957Z,1684263937.957 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:06:13.106Z,1684263973.106 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:06:48.246Z,1684264008.246 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:07:23.401Z,1684264043.401 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:07:58.542Z,1684264078.542 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:08:33.682Z,1684264113.682 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:08:36.831Z,1684264116.831 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-05-16T19:08:36.831Z,1684264116.831 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T19:08:36.832Z,1684264116.832 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2023-05-16T19:08:36.832Z,1684264116.832 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T19:08:36.843Z,1684264116.843 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T19:08:36.843Z,1684264116.843 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T19:08:37.291Z,1684264117.291 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T19:08:37.291Z,1684264117.291 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-05-16T19:08:37.292Z,1684264117.292 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T19:08:37.292Z,1684264117.292 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2023-05-16T19:08:37.658Z,1684264117.658 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T19:09:08.822Z,1684264148.822 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:09:43.963Z,1684264183.963 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:10:19.116Z,1684264219.116 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:10:54.253Z,1684264254.253 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:11:29.393Z,1684264289.393 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:11:37.926Z,1684264297.926 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-05-16T19:11:37.926Z,1684264297.926 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T19:11:37.928Z,1684264297.928 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2023-05-16T19:11:37.928Z,1684264297.928 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T19:11:37.938Z,1684264297.938 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T19:11:37.938Z,1684264297.938 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T19:11:38.345Z,1684264298.345 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T19:11:38.345Z,1684264298.345 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-05-16T19:11:38.346Z,1684264298.346 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T19:11:38.346Z,1684264298.346 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2023-05-16T19:11:38.730Z,1684264298.730 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T19:12:04.533Z,1684264324.533 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:12:39.673Z,1684264359.673 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:13:14.814Z,1684264394.814 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:13:33.092Z,1684264413.092 [NAL9602](INFO): SBD MO Status=2, MOMSN=11810, MT Status=2, MTMSN=0
2023-05-16T19:13:33.092Z,1684264413.092 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-05-16T19:13:49.954Z,1684264429.954 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:13:51.744Z,1684264431.744 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=11810, MT Status=1, MTMSN=451
2023-05-16T19:13:51.797Z,1684264431.797 [NAL9602](INFO): Sent 168 bytes from file Logs/20230516T185322/Courier0004.lzma
2023-05-16T19:13:51.798Z,1684264431.798 [NAL9602](INFO): Packets left to send: 0
2023-05-16T19:13:52.278Z,1684264432.278 [NAL9602](INFO): Received command: run Maintenance/run_backseat_on_surface.xml
2023-05-16T19:13:52.384Z,1684264432.384 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.xml
2023-05-16T19:13:52.384Z,1684264432.384 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.xml
2023-05-16T19:13:52.418Z,1684264432.418 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min
2023-05-16T19:13:52.419Z,1684264432.419 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml
2023-05-16T19:13:52.725Z,1684264432.725 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool
2023-05-16T19:13:52.728Z,1684264432.728 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min
2023-05-16T19:13:52.731Z,1684264432.731 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool
2023-05-16T19:13:52.733Z,1684264432.733 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool
2023-05-16T19:13:52.737Z,1684264432.737 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool
2023-05-16T19:13:52.742Z,1684264432.742 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool
2023-05-16T19:13:52.744Z,1684264432.744 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DetectTrough = 0 bool
2023-05-16T19:13:52.747Z,1684264432.747 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count
2023-05-16T19:13:52.750Z,1684264432.750 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count
2023-05-16T19:13:52.753Z,1684264432.753 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 %
2023-05-16T19:13:52.755Z,1684264432.755 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool
2023-05-16T19:13:52.758Z,1684264432.758 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool
2023-05-16T19:13:52.760Z,1684264432.760 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool
2023-05-16T19:13:52.763Z,1684264432.763 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool
2023-05-16T19:13:52.765Z,1684264432.765 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2023-05-16T19:13:52.768Z,1684264432.768 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool
2023-05-16T19:13:52.798Z,1684264432.798 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool
2023-05-16T19:13:52.801Z,1684264432.801 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 1 bool
2023-05-16T19:13:52.805Z,1684264432.805 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 1 bool
2023-05-16T19:13:52.823Z,1684264432.823 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2023-05-16T19:13:52.826Z,1684264432.826 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool
2023-05-16T19:13:52.829Z,1684264432.829 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count
2023-05-16T19:13:52.846Z,1684264432.846 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count
2023-05-16T19:13:52.849Z,1684264432.849 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakShallowBound = nan m
2023-05-16T19:13:52.852Z,1684264432.852 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDeepBound = nan m
2023-05-16T19:13:52.871Z,1684264432.871 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2023-05-16T19:13:52.873Z,1684264432.873 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlThreshTriggerActive = 0 bool
2023-05-16T19:13:52.876Z,1684264432.876 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlLowerThresh = nan ug/l
2023-05-16T19:13:52.879Z,1684264432.879 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlUpperThresh = nan ug/l
2023-05-16T19:13:52.893Z,1684264432.893 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesThresh = 5.000000 count
2023-05-16T19:13:52.896Z,1684264432.896 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = nan ug/l
2023-05-16T19:13:52.899Z,1684264432.899 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = nan m
2023-05-16T19:13:52.922Z,1684264432.922 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = nan degC
2023-05-16T19:13:52.925Z,1684264432.925 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg
2023-05-16T19:13:52.928Z,1684264432.928 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg
2023-05-16T19:13:52.956Z,1684264432.956 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = nan umol/l
2023-05-16T19:13:52.972Z,1684264432.972 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = nan m
2023-05-16T19:13:52.990Z,1684264432.990 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg
2023-05-16T19:13:52.993Z,1684264432.993 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg
2023-05-16T19:13:53.008Z,1684264433.008 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = nan kg/m3
2023-05-16T19:13:53.011Z,1684264433.011 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = nan m
2023-05-16T19:13:53.020Z,1684264433.020 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg
2023-05-16T19:13:53.028Z,1684264433.028 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg
2023-05-16T19:13:53.032Z,1684264433.032 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = nan ppb
2023-05-16T19:13:53.035Z,1684264433.035 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = nan m
2023-05-16T19:13:53.038Z,1684264433.038 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC
2023-05-16T19:13:53.041Z,1684264433.041 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg
2023-05-16T19:13:53.063Z,1684264433.063 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg
2023-05-16T19:13:53.066Z,1684264433.066 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchFDOMDistance = nan m
2023-05-16T19:13:53.082Z,1684264433.082 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = nan psu
2023-05-16T19:13:53.085Z,1684264433.085 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = nan m
2023-05-16T19:13:53.088Z,1684264433.088 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = nan degC
2023-05-16T19:13:53.102Z,1684264433.102 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg
2023-05-16T19:13:53.104Z,1684264433.104 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg
2023-05-16T19:13:53.107Z,1684264433.107 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = nan ug/l
2023-05-16T19:13:53.130Z,1684264433.130 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = nan m
2023-05-16T19:13:53.133Z,1684264433.133 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg
2023-05-16T19:13:53.140Z,1684264433.140 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg
2023-05-16T19:13:53.155Z,1684264433.155 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m
2023-05-16T19:13:53.158Z,1684264433.158 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = nan psu
2023-05-16T19:13:53.161Z,1684264433.161 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = nan m
2023-05-16T19:13:53.164Z,1684264433.164 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg
2023-05-16T19:13:53.178Z,1684264433.178 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg
2023-05-16T19:13:53.181Z,1684264433.181 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m
2023-05-16T19:13:53.184Z,1684264433.184 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = nan psu
2023-05-16T19:13:53.205Z,1684264433.205 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = nan m
2023-05-16T19:13:53.208Z,1684264433.208 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg
2023-05-16T19:13:53.211Z,1684264433.211 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg
2023-05-16T19:13:53.224Z,1684264433.224 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m
2023-05-16T19:13:53.227Z,1684264433.227 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.TriggeredOnChl = 0 bool
2023-05-16T19:13:53.240Z,1684264433.240 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.ChlTriggering = nan ug/l
2023-05-16T19:13:53.324Z,1684264433.324 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T19:13:53.397Z,1684264433.397 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2023-05-16T19:13:53.435Z,1684264433.435 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T19:13:53.509Z,1684264433.509 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T19:13:53.555Z,1684264433.555 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2023-05-16T19:13:53.640Z,1684264433.640 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T19:13:53.687Z,1684264433.687 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2023-05-16T19:13:53.784Z,1684264433.784 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2023-05-16T19:13:53.831Z,1684264433.831 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2023-05-16T19:13:53.882Z,1684264433.882 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Construct BackseatDriver.
2023-05-16T19:13:53.898Z,1684264433.898 [run_backseat_on_surface:C.GoToSurface](DEBUG): Construct GoToSurface.
2023-05-16T19:13:53.923Z,1684264433.923 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-05-16T19:13:53.926Z,1684264433.926 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-05-16T19:13:53.944Z,1684264433.944 [run_backseat_on_surface:F.Execute](DEBUG): Construct Execute.
2023-05-16T19:13:53.980Z,1684264433.980 [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="run_backseat_on_surface">

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

    <!-- Power the science payload. -->

    <Insert Filename="Insert/Science.xml" Id="Science"></Insert>

    <!-- Power the Backseat payload. -->

    <Guidance:BackseatDriver>
        <Parallel/>
    </Guidance:BackseatDriver>

    <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="ElapsedSinceMissionStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">run_backseat_on_surface mission has been running for <Arg Name="ElapsedSinceMissionStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and run_backseat_on_surface mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2023-05-16T19:13:53.983Z,1684264433.983 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.xml
2023-05-16T19:13:54.180Z,1684264434.180 [Default] Stopped
2023-05-16T19:13:54.180Z,1684264434.180 [Default](DEBUG): Aggregate::uninitialize Default
2023-05-16T19:13:54.180Z,1684264434.180 [Default:B.GoToSurface] Stopped
2023-05-16T19:13:54.180Z,1684264434.180 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T19:13:54.180Z,1684264434.180 [Default:CheckIn] Stopped
2023-05-16T19:13:54.181Z,1684264434.181 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-05-16T19:13:54.181Z,1684264434.181 [Default:CheckIn:Read_Iridium] Stopped
2023-05-16T19:13:54.181Z,1684264434.181 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface
2023-05-16T19:13:54.181Z,1684264434.181 [run_backseat_on_surface] Running Loop=1
2023-05-16T19:13:54.181Z,1684264434.181 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface
2023-05-16T19:13:54.181Z,1684264434.181 [run_backseat_on_surface:Science] Running Loop=1
2023-05-16T19:13:54.181Z,1684264434.181 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science
2023-05-16T19:13:54.181Z,1684264434.181 [run_backseat_on_surface:Science:A] Running Loop=1
2023-05-16T19:13:54.181Z,1684264434.181 [run_backseat_on_surface:Science:B] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:C] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:D] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:E] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:F] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T19:13:54.182Z,1684264434.182 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T19:13:54.184Z,1684264434.184 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1
2023-05-16T19:13:54.184Z,1684264434.184 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport
2023-05-16T19:13:54.184Z,1684264434.184 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2023-05-16T19:13:54.184Z,1684264434.184 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2023-05-16T19:13:54.185Z,1684264434.185 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1
2023-05-16T19:13:54.186Z,1684264434.186 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3
2023-05-16T19:13:54.186Z,1684264434.186 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T19:13:54.186Z,1684264434.186 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T19:13:54.188Z,1684264434.188 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1
2023-05-16T19:13:54.188Z,1684264434.188 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil
2023-05-16T19:13:54.188Z,1684264434.188 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T19:13:54.188Z,1684264434.188 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T19:13:54.190Z,1684264434.190 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1
2023-05-16T19:13:54.190Z,1684264434.190 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport
2023-05-16T19:13:54.190Z,1684264434.190 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2023-05-16T19:13:54.190Z,1684264434.190 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2023-05-16T19:13:54.191Z,1684264434.191 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1
2023-05-16T19:13:54.191Z,1684264434.191 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM
2023-05-16T19:13:54.191Z,1684264434.191 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T19:13:54.191Z,1684264434.191 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T19:13:54.193Z,1684264434.193 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1
2023-05-16T19:13:54.193Z,1684264434.193 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity
2023-05-16T19:13:54.195Z,1684264434.195 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1
2023-05-16T19:13:54.195Z,1684264434.195 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize.
2023-05-16T19:13:54.197Z,1684264434.197 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1
2023-05-16T19:13:54.209Z,1684264434.209 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport
2023-05-16T19:13:54.209Z,1684264434.209 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2023-05-16T19:13:54.209Z,1684264434.209 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2023-05-16T19:13:54.210Z,1684264434.210 [run_backseat_on_surface:Science:ChlThreshTrigger] Running Loop=1
2023-05-16T19:13:54.210Z,1684264434.210 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:ChlThreshTrigger
2023-05-16T19:13:54.210Z,1684264434.210 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2023-05-16T19:13:54.210Z,1684264434.210 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2023-05-16T19:13:54.210Z,1684264434.210 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1
2023-05-16T19:13:54.211Z,1684264434.211 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent
2023-05-16T19:13:54.211Z,1684264434.211 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2023-05-16T19:13:54.211Z,1684264434.211 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2023-05-16T19:13:54.211Z,1684264434.211 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1
2023-05-16T19:13:54.211Z,1684264434.211 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Initialize.
2023-05-16T19:13:54.272Z,1684264434.272 [run_backseat_on_surface:C.GoToSurface] Running Loop=1
2023-05-16T19:13:54.272Z,1684264434.272 [run_backseat_on_surface:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T19:13:54.272Z,1684264434.272 [run_backseat_on_surface:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T19:13:54.273Z,1684264434.273 [run_backseat_on_surface:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T19:13:54.273Z,1684264434.273 [run_backseat_on_surface:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T19:13:54.273Z,1684264434.273 [run_backseat_on_surface:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T19:13:54.274Z,1684264434.274 [run_backseat_on_surface:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T19:13:54.275Z,1684264434.275 [run_backseat_on_surface:CheckIn] Running Loop=1
2023-05-16T19:13:54.275Z,1684264434.275 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2023-05-16T19:13:54.275Z,1684264434.275 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2023-05-16T19:13:54.275Z,1684264434.275 [run_backseat_on_surface:B.BackseatDriver] Running Loop=1
2023-05-16T19:13:54.285Z,1684264434.285 [run_backseat_on_surface:Science] Running Loop=1
2023-05-16T19:13:54.286Z,1684264434.286 [run_backseat_on_surface:Science:ChlThreshTrigger] Stopped
2023-05-16T19:13:54.286Z,1684264434.286 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:ChlThreshTrigger
2023-05-16T19:13:54.286Z,1684264434.286 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2023-05-16T19:13:54.286Z,1684264434.286 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2023-05-16T19:13:54.287Z,1684264434.287 [run_backseat_on_surface:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectOil] Stopped
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2023-05-16T19:13:54.288Z,1684264434.288 [run_backseat_on_surface:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:PeakDetectChl] Stopped
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2023-05-16T19:13:54.289Z,1684264434.289 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2023-05-16T19:13:54.290Z,1684264434.290 [run_backseat_on_surface:Science:Read_Oil] Stopped
2023-05-16T19:13:54.290Z,1684264434.290 [run_backseat_on_surface:Science:F] Stopped
2023-05-16T19:13:54.290Z,1684264434.290 [run_backseat_on_surface:Science:E] Running Loop=1
2023-05-16T19:13:54.290Z,1684264434.290 [run_backseat_on_surface:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2023-05-16T19:13:54.290Z,1684264434.290 [run_backseat_on_surface:Science:D] Stopped
2023-05-16T19:13:54.290Z,1684264434.290 [run_backseat_on_surface:Science:C] Running Loop=1
2023-05-16T19:13:54.291Z,1684264434.291 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2023-05-16T19:13:54.292Z,1684264434.292 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2023-05-16T19:13:54.292Z,1684264434.292 [run_backseat_on_surface:Science:B] Running Loop=1
2023-05-16T19:13:54.292Z,1684264434.292 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2023-05-16T19:13:54.293Z,1684264434.293 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2023-05-16T19:13:54.293Z,1684264434.293 [run_backseat_on_surface:Science:A] Stopped
2023-05-16T19:13:54.297Z,1684264434.297 [BackseatComponent](INFO): Powering up
2023-05-16T19:13:54.298Z,1684264434.298 [BackseatComponent](INFO): Subscribing to LCM channels.
2023-05-16T19:13:54.414Z,1684264434.414 [WetLabsBB2FL](INFO): Powering up
2023-05-16T19:13:54.563Z,1684264434.563 [Power24vConverter](INFO): Powering up.
2023-05-16T19:13:54.589Z,1684264434.589 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-05-16T19:14:25.098Z,1684264465.098 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:14:39.023Z,1684264479.023 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-05-16T19:14:39.023Z,1684264479.023 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-05-16T19:14:39.024Z,1684264479.024 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2023-05-16T19:14:39.024Z,1684264479.024 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-05-16T19:14:39.039Z,1684264479.039 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-05-16T19:14:39.039Z,1684264479.039 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-05-16T19:14:39.443Z,1684264479.443 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-05-16T19:14:39.443Z,1684264479.443 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-05-16T19:14:39.443Z,1684264479.443 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-05-16T19:14:39.443Z,1684264479.443 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2023-05-16T19:14:39.827Z,1684264479.827 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-05-16T19:14:58.399Z,1684264498.399 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-05-16T19:14:58.399Z,1684264498.399 [NAL9602] Data Fault, FailCount= 2
2023-05-16T19:14:58.399Z,1684264498.399 [NAL9602](ERROR): Data Fault
2023-05-16T19:14:58.443Z,1684264498.443 [CBIT](ERROR): Data Fault in component: NAL9602
2023-05-16T19:14:58.806Z,1684264498.806 [NAL9602](INFO): Powering down
2023-05-16T19:14:59.649Z,1684264499.649 [CBIT](INFO): Clearing failed state for component NAL9602
2023-05-16T19:14:59.649Z,1684264499.649 [NAL9602] No Fault, FailCount= 2
2023-05-16T19:15:00.238Z,1684264500.238 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:15:03.400Z,1684264503.400 [BackseatComponent](IMPORTANT): calanus: Running AyeRIS backseat app. Logging to: 20230516T191515
2023-05-16T19:15:03.438Z,1684264503.438 [BackseatComponent](IMPORTANT): 2023-05-16 19:15:18.288 | INFO     | __main__:<module>:125 - $ELC,2023-05-16 19:15:18.954,20.170,105.605,0.00,23.63,16.76,23.63,0.16,0.14,14.30,1,0,0,500,1

2023-05-16T19:15:24.691Z,1684264524.691 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_disk_space with code: 1932
2023-05-16T19:15:24.693Z,1684264524.693 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_counts with code: 1933
2023-05-16T19:15:24.696Z,1684264524.696 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_shape with code: 1934
2023-05-16T19:15:24.699Z,1684264524.699 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_size with code: 1935
2023-05-16T19:15:24.701Z,1684264524.701 [run_backseat_on_surface:B.BackseatDriver](INFO): Created data writer for _.ayeris_particle_slope with code: 1936
2023-05-16T19:15:29.103Z,1684264529.103 [NAL9602](INFO): Powering up NAL9602
2023-05-16T19:15:31.767Z,1684264531.767 [BackseatComponent](INFO): Created data reader for Depth_Keller.enableBroadcast with code: 1584
2023-05-16T19:15:31.767Z,1684264531.767 [BackseatComponent](INFO): Requesting data from Depth_Keller.enableBroadcast (1584). Requested size is: 1
2023-05-16T19:15:31.769Z,1684264531.769 [BackseatComponent](INFO): Created universal data reader for depth with code: 6
2023-05-16T19:15:31.769Z,1684264531.769 [BackseatComponent](INFO): Requesting data from depth (6). Requested size is: 2
2023-05-16T19:15:31.923Z,1684264531.923 [Depth_Keller](ERROR): Failed to copy Depth_Keller.enableBroadcast's data value to LCM message.
2023-05-16T19:15:31.923Z,1684264531.923 [Depth_Keller](INFO): Activating messaging.
2023-05-16T19:15:35.378Z,1684264535.378 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:15:40.012Z,1684264540.012 [NAL9602](INFO): NAL9602 initialized
2023-05-16T19:16:02.236Z,1684264562.236 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191600.00,A,3648.17331,N,12147.28833,W,0.039,0.00,160523,,,A*77
2023-05-16T19:16:02.239Z,1684264562.239 [NAL9602](INFO): GPS fix at 20230516T191600: (36.802889, -121.788139)
2023-05-16T19:16:02.279Z,1684264562.279 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2023-05-16T19:16:02.279Z,1684264562.279 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1
2023-05-16T19:16:02.681Z,1684264562.681 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-05-16T19:16:10.542Z,1684264570.542 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:16:20.085Z,1684264580.085 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=11811, MT Status=1, MTMSN=452
2023-05-16T19:16:20.141Z,1684264580.141 [NAL9602](INFO): Sent 223 bytes from file Logs/20230516T185322/Courier0007.lzma
2023-05-16T19:16:20.142Z,1684264580.142 [NAL9602](INFO): Packets left to send: 0
2023-05-16T19:16:20.582Z,1684264580.582 [NAL9602](INFO): Received command: gfscan
2023-05-16T19:16:20.678Z,1684264580.678 [CommandExec](IMPORTANT): got command gfscan
2023-05-16T19:16:20.919Z,1684264580.919 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-16T19:16:21.507Z,1684264581.507 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:22.511Z,1684264582.511 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:23.515Z,1684264583.515 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:24.519Z,1684264584.519 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:25.523Z,1684264585.523 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:26.528Z,1684264586.528 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:27.531Z,1684264587.531 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:28.535Z,1684264588.535 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:29.539Z,1684264589.539 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:30.543Z,1684264590.543 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:31.547Z,1684264591.547 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:32.551Z,1684264592.551 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:33.279Z,1684264593.279 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.454202
CHAN A1 (24V): 0.677785
CHAN A2 (12V): 0.257214
CHAN A3 (5V): 0.063717
CHAN B0 (3.3V): 0.028764
CHAN B1 (3.15aV): 0.029785
CHAN B2 (3.15bV): 0.029315
CHAN B3 (GND): -0.035458
OPEN: 0.011115
Full Scale: +/- 1 mA
2023-05-16T19:16:39.307Z,1684264599.307 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=11812, MT Status=1, MTMSN=453
2023-05-16T19:16:39.361Z,1684264599.361 [NAL9602](INFO): Sent 332 bytes from file Logs/20230516T185322/Express0001.lzma
2023-05-16T19:16:39.362Z,1684264599.362 [NAL9602](INFO): Packets left to send: 3
2023-05-16T19:16:39.810Z,1684264599.810 [NAL9602](INFO): Received command: ibit
2023-05-16T19:16:39.862Z,1684264599.862 [CommandExec](IMPORTANT): got command ibit
2023-05-16T19:16:40.144Z,1684264600.144 [IBIT](IMPORTANT): Beginning Initiated BIT
2023-05-16T19:16:40.145Z,1684264600.145 [IBIT](IMPORTANT): Beginning control surface checks.
2023-05-16T19:16:40.148Z,1684264600.148 [CBIT](IMPORTANT): Beginning ground fault scan
2023-05-16T19:16:40.588Z,1684264600.588 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:41.587Z,1684264601.587 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:42.591Z,1684264602.591 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:43.595Z,1684264603.595 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:44.612Z,1684264604.612 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:45.615Z,1684264605.615 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:45.682Z,1684264605.682 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2023-05-16T19:16:46.666Z,1684264606.666 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:47.658Z,1684264607.658 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:48.662Z,1684264608.662 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:49.666Z,1684264609.666 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:50.662Z,1684264610.662 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:51.475Z,1684264611.475 [NAL9602](INFO): SBD MO Status=1, MOMSN=11813, MT Status=0, MTMSN=0
2023-05-16T19:16:51.526Z,1684264611.526 [NAL9602](INFO): Sent 332 bytes from file Logs/20230516T185322/Express0001.lzma
2023-05-16T19:16:51.526Z,1684264611.526 [NAL9602](INFO): Packets left to send: 2
2023-05-16T19:16:51.662Z,1684264611.662 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2023-05-16T19:16:52.443Z,1684264612.443 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.419041
CHAN A1 (24V): 0.679538
CHAN A2 (12V): 0.273324
CHAN A3 (5V): 0.065473
CHAN B0 (3.3V): 0.031487
CHAN B1 (3.15aV): 0.029605
CHAN B2 (3.15bV): 0.026207
CHAN B3 (GND): -0.042767
OPEN: 0.009350
Full Scale: +/- 1 mA
2023-05-16T19:17:03.356Z,1684264623.356 [NAL9602](INFO): SBD MO Status=1, MOMSN=11814, MT Status=0, MTMSN=0
2023-05-16T19:17:03.405Z,1684264623.405 [NAL9602](INFO): Sent 332 bytes from file Logs/20230516T185322/Express0001.lzma
2023-05-16T19:17:03.406Z,1684264623.406 [NAL9602](INFO): Packets left to send: 1
2023-05-16T19:17:11.625Z,1684264631.625 [NAL9602](INFO): SBD MO Status=1, MOMSN=11815, MT Status=0, MTMSN=0
2023-05-16T19:17:11.674Z,1684264631.674 [NAL9602](INFO): Sent 68 bytes from file Logs/20230516T185322/Express0001.lzma
2023-05-16T19:17:11.674Z,1684264631.674 [NAL9602](INFO): Packets left to send: 0
2023-05-16T19:17:18.042Z,1684264638.042 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003239
2023-05-16T19:17:20.330Z,1684264640.330 [NAL9602](INFO): SBD MO Status=1, MOMSN=11816, MT Status=0, MTMSN=0
2023-05-16T19:17:20.381Z,1684264640.381 [NAL9602](INFO): Sent 187 bytes from file Logs/20230516T185322/Express0005.lzma
2023-05-16T19:17:20.382Z,1684264640.382 [NAL9602](INFO): Packets left to send: 0
2023-05-16T19:17:21.540Z,1684264641.540 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191719.00,A,3648.17664,N,12147.28531,W,0.369,0.00,160523,,,A*72
2023-05-16T19:17:21.542Z,1684264641.542 [NAL9602](INFO): GPS fix at 20230516T191719: (36.802944, -121.788089)
2023-05-16T19:17:23.960Z,1684264643.960 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191722.00,A,3648.17630,N,12147.28580,W,0.117,0.00,160523,,,A*7A
2023-05-16T19:17:23.962Z,1684264643.962 [NAL9602](INFO): GPS fix at 20230516T191722: (36.802938, -121.788097)
2023-05-16T19:17:25.932Z,1684264645.932 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230516T185322/Courier0010.lzma
2023-05-16T19:17:26.003Z,1684264646.003 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 5
Latitude: 36.802937 Longitude: -121.788094
2023-05-16T19:17:26.404Z,1684264646.404 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.660000
2023-05-16T19:17:26.405Z,1684264646.405 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2023-05-16T19:17:26.405Z,1684264646.405 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2023-05-16T19:17:26.827Z,1684264646.827 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2023-05-16T19:17:26.827Z,1684264646.827 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2023-05-16T19:17:26.828Z,1684264646.828 [IBIT](IMPORTANT): Pressure:9.280527 PSI
2023-05-16T19:17:26.829Z,1684264646.829 [IBIT](IMPORTANT): Humidity:17.384935 %
2023-05-16T19:17:26.935Z,1684264646.935 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Courier0010.lzma.bak
2023-05-16T19:17:26.935Z,1684264646.935 [DataOverHttps](INFO): SBD MOMSN=18317188
2023-05-16T19:17:27.232Z,1684264647.232 [IBIT](IMPORTANT): Vehicle Pitch:-1.208216 degrees
2023-05-16T19:17:27.233Z,1684264647.233 [IBIT](IMPORTANT): Vehicle  Roll:-1.220496 degrees
2023-05-16T19:17:27.234Z,1684264647.234 [IBIT](IMPORTANT): Vehicle  Heading:308.479431 degrees
2023-05-16T19:17:27.615Z,1684264647.615 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2023-05-16T19:17:27.616Z,1684264647.616 [IBIT](IMPORTANT): buoyancyNeutral: 281.701202 cc
2023-05-16T19:17:27.616Z,1684264647.616 [IBIT](IMPORTANT): massDefault: 1.576239 cm
2023-05-16T19:17:27.616Z,1684264647.616 [IBIT](IMPORTANT): stopDepth: 290.000000 m
2023-05-16T19:17:27.616Z,1684264647.616 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2023-05-16T19:17:27.616Z,1684264647.616 [IBIT](IMPORTANT): IBIT PASSED
2023-05-16T19:17:43.018Z,1684264663.018 [DataOverHttps](INFO): Sending 949 bytes from file Logs/20230516T185322/Express0008.lzma
2023-05-16T19:17:44.019Z,1684264664.019 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Express0008.lzma.bak
2023-05-16T19:17:44.019Z,1684264664.019 [DataOverHttps](INFO): SBD MOMSN=18317191
2023-05-16T19:17:56.766Z,1684264676.766 [NAL9602](INFO): Not Powering down - fast GPS
2023-05-16T19:18:03.210Z,1684264683.210 [DataOverHttps](INFO): Sending 516 bytes from file Logs/20230516T185322/Express0011.lzma
2023-05-16T19:18:04.211Z,1684264684.211 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Express0011.lzma.bak
2023-05-16T19:18:04.211Z,1684264684.211 [DataOverHttps](INFO): SBD MOMSN=18317195
2023-05-16T19:18:05.650Z,1684264685.650 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped
2023-05-16T19:18:05.651Z,1684264685.651 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1
2023-05-16T19:18:05.651Z,1684264685.651 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-16T19:23:06.242Z,1684264986.242 [run_backseat_on_surface:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-16T19:23:06.242Z,1684264986.242 [run_backseat_on_surface:CheckIn:C.Wait] Stopped
2023-05-16T19:23:06.242Z,1684264986.242 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T19:23:06.243Z,1684264986.243 [run_backseat_on_surface:CheckIn:D] Running Loop=1
2023-05-16T19:23:06.625Z,1684264986.625 [run_backseat_on_surface:CheckIn:D] Stopped
2023-05-16T19:23:06.625Z,1684264986.625 [run_backseat_on_surface:CheckIn:E] Running Loop=1
2023-05-16T19:23:07.033Z,1684264987.033 [run_backseat_on_surface:CheckIn:E](IMPORTANT): run_backseat_on_surface mission has been running for 9.207395 min 
2023-05-16T19:23:07.033Z,1684264987.033 [run_backseat_on_surface:CheckIn:E] Stopped
2023-05-16T19:23:07.033Z,1684264987.033 [run_backseat_on_surface:CheckIn](INFO): Completed run_backseat_on_surface:CheckIn
2023-05-16T19:23:07.033Z,1684264987.033 [run_backseat_on_surface:CheckIn] Stopped
2023-05-16T19:23:07.033Z,1684264987.033 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2023-05-16T19:23:07.034Z,1684264987.034 [run_backseat_on_surface:CheckIn](INFO): Running loop #2
2023-05-16T19:23:07.034Z,1684264987.034 [run_backseat_on_surface:CheckIn] Running Loop=2
2023-05-16T19:23:07.034Z,1684264987.034 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2023-05-16T19:23:07.034Z,1684264987.034 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2023-05-16T19:23:09.036Z,1684264989.036 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192307.00,A,3648.17556,N,12147.28424,W,0.019,0.00,160523,,,D*7C
2023-05-16T19:23:09.038Z,1684264989.038 [NAL9602](INFO): GPS fix at 20230516T192307: (36.802926, -121.788071)
2023-05-16T19:23:09.069Z,1684264989.069 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2023-05-16T19:23:09.069Z,1684264989.069 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1
2023-05-16T19:23:16.292Z,1684264996.292 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20230516T185322/Courier0013.lzma
2023-05-16T19:23:17.295Z,1684264997.295 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Courier0013.lzma.bak
2023-05-16T19:23:17.295Z,1684264997.295 [DataOverHttps](INFO): SBD MOMSN=18317318
2023-05-16T19:23:33.410Z,1684265013.410 [DataOverHttps](INFO): Sending 645 bytes from file Logs/20230516T185322/Express0014.lzma
2023-05-16T19:23:34.411Z,1684265014.411 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Express0014.lzma.bak
2023-05-16T19:23:34.411Z,1684265014.411 [DataOverHttps](INFO): SBD MOMSN=18317321
2023-05-16T19:23:36.119Z,1684265016.119 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped
2023-05-16T19:23:36.119Z,1684265016.119 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1
2023-05-16T19:23:36.119Z,1684265016.119 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-16T19:23:56.782Z,1684265036.782 [NAL9602](INFO): SBD MO Status=2, MOMSN=11817, MT Status=2, MTMSN=0
2023-05-16T19:23:56.783Z,1684265036.783 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2023-05-16T19:24:48.085Z,1684265088.085 [NAL9602](INFO): SBD MO Status=0, MOMSN=11817, MT Status=0, MTMSN=0
2023-05-16T19:24:48.085Z,1684265088.085 [NAL9602](INFO): No messages in MT queue
2023-05-16T19:25:18.788Z,1684265118.788 [NAL9602](INFO): Not Powering down - fast GPS
2023-05-16T19:25:43.925Z,1684265143.925 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015909 psu
2023-05-16T19:25:44.928Z,1684265144.928 [CTD_Seabird](ERROR): Salinity reading out of range: 0.054518 psu
2023-05-16T19:25:45.940Z,1684265145.940 [CTD_Seabird](ERROR): Salinity reading out of range: 0.037175 psu
2023-05-16T19:25:46.944Z,1684265146.944 [CTD_Seabird](ERROR): Salinity reading out of range: 0.056927 psu
2023-05-16T19:25:47.947Z,1684265147.947 [CTD_Seabird](ERROR): Salinity reading out of range: 0.040010 psu
2023-05-16T19:25:48.952Z,1684265148.952 [CTD_Seabird](ERROR): Salinity reading out of range: 0.066084 psu
2023-05-16T19:25:49.955Z,1684265149.955 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015780 psu
2023-05-16T19:25:50.959Z,1684265150.959 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013785 psu
2023-05-16T19:25:51.965Z,1684265151.965 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012713 psu
2023-05-16T19:25:52.967Z,1684265152.967 [CTD_Seabird](ERROR): Salinity reading out of range: 0.026089 psu
2023-05-16T19:25:53.971Z,1684265153.971 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012237 psu
2023-05-16T19:25:54.975Z,1684265154.975 [CTD_Seabird](ERROR): Salinity reading out of range: 0.022525 psu
2023-05-16T19:25:55.979Z,1684265155.979 [CTD_Seabird](ERROR): Salinity reading out of range: 0.068430 psu
2023-05-16T19:25:56.983Z,1684265156.983 [CTD_Seabird](ERROR): Salinity reading out of range: 0.046683 psu
2023-05-16T19:25:57.987Z,1684265157.987 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013078 psu
2023-05-16T19:25:58.991Z,1684265158.991 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014717 psu
2023-05-16T19:25:59.995Z,1684265159.995 [CTD_Seabird](ERROR): Salinity reading out of range: 0.041121 psu
2023-05-16T19:26:00.000Z,1684265161.000 [CTD_Seabird](ERROR): Salinity reading out of range: 0.106074 psu
2023-05-16T19:26:02.003Z,1684265162.003 [CTD_Seabird](ERROR): Salinity reading out of range: 0.107108 psu
2023-05-16T19:26:03.007Z,1684265163.007 [CTD_Seabird](ERROR): Salinity reading out of range: 0.075737 psu
2023-05-16T19:26:04.011Z,1684265164.011 [CTD_Seabird](ERROR): Salinity reading out of range: 0.020365 psu
2023-05-16T19:26:05.016Z,1684265165.016 [CTD_Seabird](ERROR): Salinity reading out of range: 0.020713 psu
2023-05-16T19:26:06.019Z,1684265166.019 [CTD_Seabird](ERROR): Salinity reading out of range: 0.020953 psu
2023-05-16T19:26:07.023Z,1684265167.023 [CTD_Seabird](ERROR): Salinity reading out of range: 0.021630 psu
2023-05-16T19:26:08.027Z,1684265168.027 [CTD_Seabird](ERROR): Salinity reading out of range: 0.021376 psu
2023-05-16T19:26:09.031Z,1684265169.031 [CTD_Seabird](ERROR): Salinity reading out of range: 0.020901 psu
2023-05-16T19:26:10.035Z,1684265170.035 [CTD_Seabird](ERROR): Salinity reading out of range: 0.020425 psu
2023-05-16T19:26:11.039Z,1684265171.039 [CTD_Seabird](ERROR): Salinity reading out of range: 0.019893 psu
2023-05-16T19:26:12.043Z,1684265172.043 [CTD_Seabird](ERROR): Salinity reading out of range: 0.019471 psu
2023-05-16T19:26:13.048Z,1684265173.048 [CTD_Seabird](ERROR): Salinity reading out of range: 0.019047 psu
2023-05-16T19:26:14.052Z,1684265174.052 [CTD_Seabird](ERROR): Salinity reading out of range: 0.018622 psu
2023-05-16T19:26:15.055Z,1684265175.055 [CTD_Seabird](ERROR): Salinity reading out of range: 0.018252 psu
2023-05-16T19:26:16.059Z,1684265176.059 [CTD_Seabird](ERROR): Salinity reading out of range: 0.017936 psu
2023-05-16T19:26:17.064Z,1684265177.064 [CTD_Seabird](ERROR): Salinity reading out of range: 0.017178 psu
2023-05-16T19:26:18.067Z,1684265178.067 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014766 psu
2023-05-16T19:26:19.075Z,1684265179.075 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014062 psu
2023-05-16T19:26:20.075Z,1684265180.075 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013247 psu
2023-05-16T19:26:21.079Z,1684265181.079 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011992 psu
2023-05-16T19:26:22.083Z,1684265182.083 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009373 psu
2023-05-16T19:26:23.088Z,1684265183.088 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009217 psu
2023-05-16T19:26:24.091Z,1684265184.091 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010208 psu
2023-05-16T19:26:25.119Z,1684265185.119 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010654 psu
2023-05-16T19:26:26.123Z,1684265186.123 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010826 psu
2023-05-16T19:26:27.127Z,1684265187.127 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010944 psu
2023-05-16T19:26:28.131Z,1684265188.131 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010896 psu
2023-05-16T19:26:29.135Z,1684265189.135 [CTD_Seabird](ERROR): Salinity reading out of range: 0.026345 psu
2023-05-16T19:26:30.139Z,1684265190.139 [CTD_Seabird](ERROR): Salinity reading out of range: 0.034434 psu
2023-05-16T19:26:31.144Z,1684265191.144 [CTD_Seabird](ERROR): Salinity reading out of range: 0.059954 psu
2023-05-16T19:26:32.147Z,1684265192.147 [CTD_Seabird](ERROR): Salinity reading out of range: 0.047158 psu
2023-05-16T19:26:33.152Z,1684265193.152 [CTD_Seabird](ERROR): Salinity reading out of range: 0.036890 psu
2023-05-16T19:26:34.155Z,1684265194.155 [CTD_Seabird](ERROR): Salinity reading out of range: 0.029605 psu
2023-05-16T19:26:35.160Z,1684265195.160 [CTD_Seabird](ERROR): Salinity reading out of range: 0.050964 psu
2023-05-16T19:26:36.163Z,1684265196.163 [CTD_Seabird](ERROR): Salinity reading out of range: 0.019858 psu
2023-05-16T19:26:37.167Z,1684265197.167 [CTD_Seabird](ERROR): Salinity reading out of range: 0.018248 psu
2023-05-16T19:26:38.171Z,1684265198.171 [CTD_Seabird](ERROR): Salinity reading out of range: 0.018761 psu
2023-05-16T19:26:39.175Z,1684265199.175 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013970 psu
2023-05-16T19:26:40.179Z,1684265200.179 [CTD_Seabird](ERROR): Salinity reading out of range: 0.018110 psu
2023-05-16T19:26:41.184Z,1684265201.184 [CTD_Seabird](ERROR): Salinity reading out of range: 0.020135 psu
2023-05-16T19:26:42.187Z,1684265202.187 [CTD_Seabird](ERROR): Salinity reading out of range: 0.026927 psu
2023-05-16T19:26:43.191Z,1684265203.191 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015060 psu
2023-05-16T19:26:44.195Z,1684265204.195 [CTD_Seabird](ERROR): Salinity reading out of range: 0.018763 psu
2023-05-16T19:26:45.199Z,1684265205.199 [CTD_Seabird](ERROR): Salinity reading out of range: 0.036050 psu
2023-05-16T19:26:46.204Z,1684265206.204 [CTD_Seabird](ERROR): Salinity reading out of range: 0.047597 psu
2023-05-16T19:26:47.207Z,1684265207.207 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012686 psu
2023-05-16T19:26:48.211Z,1684265208.211 [CTD_Seabird](ERROR): Salinity reading out of range: 0.017056 psu
2023-05-16T19:26:49.215Z,1684265209.215 [CTD_Seabird](ERROR): Salinity reading out of range: 0.093022 psu
2023-05-16T19:26:50.222Z,1684265210.222 [CTD_Seabird](ERROR): Salinity reading out of range: 0.038647 psu
2023-05-16T19:26:51.223Z,1684265211.223 [CTD_Seabird](ERROR): Salinity reading out of range: 0.027648 psu
2023-05-16T19:26:52.228Z,1684265212.228 [CTD_Seabird](ERROR): Salinity reading out of range: 0.031034 psu
2023-05-16T19:26:53.231Z,1684265213.231 [CTD_Seabird](ERROR): Salinity reading out of range: 0.030201 psu
2023-05-16T19:26:54.235Z,1684265214.235 [CTD_Seabird](ERROR): Salinity reading out of range: 0.019515 psu
2023-05-16T19:26:55.239Z,1684265215.239 [CTD_Seabird](ERROR): Salinity reading out of range: 0.016260 psu
2023-05-16T19:26:56.243Z,1684265216.243 [CTD_Seabird](ERROR): Salinity reading out of range: 0.029615 psu
2023-05-16T19:26:57.247Z,1684265217.247 [CTD_Seabird](ERROR): Salinity reading out of range: 0.019086 psu
2023-05-16T19:26:58.251Z,1684265218.251 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013414 psu
2023-05-16T19:26:59.255Z,1684265219.255 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011963 psu
2023-05-16T19:27:00.259Z,1684265220.259 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012303 psu
2023-05-16T19:27:01.263Z,1684265221.263 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012476 psu
2023-05-16T19:27:02.267Z,1684265222.267 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009579 psu
2023-05-16T19:27:03.272Z,1684265223.272 [CTD_Seabird](ERROR): Salinity reading out of range: 0.023136 psu
2023-05-16T19:27:04.275Z,1684265224.275 [CTD_Seabird](ERROR): Salinity reading out of range: 0.018006 psu
2023-05-16T19:27:05.279Z,1684265225.279 [CTD_Seabird](ERROR): Salinity reading out of range: 0.016657 psu
2023-05-16T19:27:06.283Z,1684265226.283 [CTD_Seabird](ERROR): Salinity reading out of range: 0.030789 psu
2023-05-16T19:27:07.287Z,1684265227.287 [CTD_Seabird](ERROR): Salinity reading out of range: 0.032831 psu
2023-05-16T19:27:08.291Z,1684265228.291 [CTD_Seabird](ERROR): Salinity reading out of range: 0.019158 psu
2023-05-16T19:27:09.296Z,1684265229.296 [CTD_Seabird](ERROR): Salinity reading out of range: 0.023463 psu
2023-05-16T19:27:10.299Z,1684265230.299 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014821 psu
2023-05-16T19:27:11.303Z,1684265231.303 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015333 psu
2023-05-16T19:27:12.307Z,1684265232.307 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014548 psu
2023-05-16T19:27:13.312Z,1684265233.312 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010954 psu
2023-05-16T19:27:14.315Z,1684265234.315 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014218 psu
2023-05-16T19:27:15.320Z,1684265235.320 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011689 psu
2023-05-16T19:27:16.323Z,1684265236.323 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015355 psu
2023-05-16T19:27:17.328Z,1684265237.328 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015471 psu
2023-05-16T19:27:18.332Z,1684265238.332 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015136 psu
2023-05-16T19:27:19.335Z,1684265239.335 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015818 psu
2023-05-16T19:27:20.339Z,1684265240.339 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014466 psu
2023-05-16T19:27:21.343Z,1684265241.343 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013059 psu
2023-05-16T19:27:22.347Z,1684265242.347 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013569 psu
2023-05-16T19:27:23.351Z,1684265243.351 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012389 psu
2023-05-16T19:27:24.355Z,1684265244.355 [CTD_Seabird](ERROR): Salinity reading out of range: 0.014649 psu
2023-05-16T19:27:25.359Z,1684265245.359 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015105 psu
2023-05-16T19:27:26.363Z,1684265246.363 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011778 psu
2023-05-16T19:27:27.368Z,1684265247.368 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010881 psu
2023-05-16T19:27:28.371Z,1684265248.371 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011108 psu
2023-05-16T19:27:29.375Z,1684265249.375 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009764 psu
2023-05-16T19:27:30.379Z,1684265250.379 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011506 psu
2023-05-16T19:27:31.383Z,1684265251.383 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011565 psu
2023-05-16T19:27:32.387Z,1684265252.387 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011511 psu
2023-05-16T19:27:33.392Z,1684265253.392 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011682 psu
2023-05-16T19:27:34.395Z,1684265254.395 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012812 psu
2023-05-16T19:27:35.400Z,1684265255.400 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010505 psu
2023-05-16T19:27:36.404Z,1684265256.404 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010675 psu
2023-05-16T19:27:37.407Z,1684265257.407 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009723 psu
2023-05-16T19:27:38.412Z,1684265258.412 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010735 psu
2023-05-16T19:27:39.416Z,1684265259.416 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009783 psu
2023-05-16T19:27:40.420Z,1684265260.420 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008777 psu
2023-05-16T19:27:41.424Z,1684265261.424 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008667 psu
2023-05-16T19:27:42.427Z,1684265262.427 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006892 psu
2023-05-16T19:27:43.432Z,1684265263.432 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008391 psu
2023-05-16T19:27:44.436Z,1684265264.436 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008337 psu
2023-05-16T19:27:45.439Z,1684265265.439 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007504 psu
2023-05-16T19:27:46.443Z,1684265266.443 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006952 psu
2023-05-16T19:27:47.476Z,1684265267.476 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006787 psu
2023-05-16T19:27:48.479Z,1684265268.479 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005581 psu
2023-05-16T19:27:49.484Z,1684265269.484 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006514 psu
2023-05-16T19:27:50.487Z,1684265270.487 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006240 psu
2023-05-16T19:27:51.491Z,1684265271.491 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006021 psu
2023-05-16T19:27:52.495Z,1684265272.495 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004662 psu
2023-05-16T19:27:53.499Z,1684265273.499 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004126 psu
2023-05-16T19:27:54.503Z,1684265274.503 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006408 psu
2023-05-16T19:27:55.507Z,1684265275.507 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004988 psu
2023-05-16T19:27:56.511Z,1684265276.511 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004181 psu
2023-05-16T19:27:57.515Z,1684265277.515 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005861 psu
2023-05-16T19:27:58.520Z,1684265278.520 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005425 psu
2023-05-16T19:27:59.523Z,1684265279.523 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006742 psu
2023-05-16T19:28:00.527Z,1684265280.527 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004505 psu
2023-05-16T19:28:01.536Z,1684265281.536 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008913 psu
2023-05-16T19:28:02.535Z,1684265282.535 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007965 psu
2023-05-16T19:28:03.539Z,1684265283.539 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005591 psu
2023-05-16T19:28:04.543Z,1684265284.543 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007744 psu
2023-05-16T19:28:05.548Z,1684265285.548 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006746 psu
2023-05-16T19:28:06.551Z,1684265286.551 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004615 psu
2023-05-16T19:28:07.556Z,1684265287.556 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004616 psu
2023-05-16T19:28:08.559Z,1684265288.559 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006748 psu
2023-05-16T19:28:09.564Z,1684265289.564 [CTD_Seabird](ERROR): Salinity reading out of range: 0.004995 psu
2023-05-16T19:28:10.567Z,1684265290.567 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008249 psu
2023-05-16T19:28:11.572Z,1684265291.572 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006253 psu
2023-05-16T19:28:12.575Z,1684265292.575 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005214 psu
2023-05-16T19:28:13.579Z,1684265293.579 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005269 psu
2023-05-16T19:28:14.584Z,1684265294.584 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005215 psu
2023-05-16T19:28:15.587Z,1684265295.587 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005651 psu
2023-05-16T19:28:16.601Z,1684265296.601 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007140 psu
2023-05-16T19:28:17.603Z,1684265297.603 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010329 psu
2023-05-16T19:28:18.607Z,1684265298.607 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005653 psu
2023-05-16T19:28:19.611Z,1684265299.611 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006092 psu
2023-05-16T19:28:20.615Z,1684265300.615 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005162 psu
2023-05-16T19:28:21.619Z,1684265301.619 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005054 psu
2023-05-16T19:28:22.624Z,1684265302.624 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005709 psu
2023-05-16T19:28:23.627Z,1684265303.627 [CTD_Seabird](ERROR): Salinity reading out of range: 0.005217 psu
2023-05-16T19:28:24.666Z,1684265304.666 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006755 psu
2023-05-16T19:28:25.670Z,1684265305.670 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008145 psu
2023-05-16T19:28:26.674Z,1684265306.674 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008034 psu
2023-05-16T19:28:28.670Z,1684265308.670 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007644 psu
2023-05-16T19:28:29.674Z,1684265309.674 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008482 psu
2023-05-16T19:28:30.666Z,1684265310.666 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008930 psu
2023-05-16T19:28:31.674Z,1684265311.674 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008371 psu
2023-05-16T19:28:32.674Z,1684265312.674 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010054 psu
2023-05-16T19:28:33.668Z,1684265313.668 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010449 psu
2023-05-16T19:28:34.671Z,1684265314.671 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010224 psu
2023-05-16T19:28:35.676Z,1684265315.676 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012090 psu
2023-05-16T19:28:36.679Z,1684265316.679 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009380 psu
2023-05-16T19:28:36.799Z,1684265316.799 [run_backseat_on_surface:CheckIn:C.Wait](INFO): Done Waiting.
2023-05-16T19:28:36.799Z,1684265316.799 [run_backseat_on_surface:CheckIn:C.Wait] Stopped
2023-05-16T19:28:36.799Z,1684265316.799 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T19:28:36.799Z,1684265316.799 [run_backseat_on_surface:CheckIn:D] Running Loop=1
2023-05-16T19:28:37.203Z,1684265317.203 [run_backseat_on_surface:CheckIn:D] Stopped
2023-05-16T19:28:37.203Z,1684265317.203 [run_backseat_on_surface:CheckIn:E] Running Loop=1
2023-05-16T19:28:37.577Z,1684265317.577 [run_backseat_on_surface:CheckIn:E](IMPORTANT): run_backseat_on_surface mission has been running for 14.717024 min 
2023-05-16T19:28:37.577Z,1684265317.577 [run_backseat_on_surface:CheckIn:E] Stopped
2023-05-16T19:28:37.578Z,1684265317.578 [run_backseat_on_surface:CheckIn](INFO): Completed run_backseat_on_surface:CheckIn
2023-05-16T19:28:37.578Z,1684265317.578 [run_backseat_on_surface:CheckIn] Stopped
2023-05-16T19:28:37.578Z,1684265317.578 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2023-05-16T19:28:37.578Z,1684265317.578 [run_backseat_on_surface:CheckIn](INFO): Running loop #3
2023-05-16T19:28:37.578Z,1684265317.578 [run_backseat_on_surface:CheckIn] Running Loop=3
2023-05-16T19:28:37.578Z,1684265317.578 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2023-05-16T19:28:37.578Z,1684265317.578 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2023-05-16T19:28:37.685Z,1684265317.685 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009549 psu
2023-05-16T19:28:38.687Z,1684265318.687 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011354 psu
2023-05-16T19:28:39.585Z,1684265319.585 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192838.00,A,3648.17257,N,12147.28456,W,0.972,6.02,160523,,,D*78
2023-05-16T19:28:39.588Z,1684265319.588 [NAL9602](INFO): GPS fix at 20230516T192838: (36.802876, -121.788076)
2023-05-16T19:28:39.601Z,1684265319.601 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2023-05-16T19:28:39.601Z,1684265319.601 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1
2023-05-16T19:28:39.691Z,1684265319.691 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011185 psu
2023-05-16T19:28:40.696Z,1684265320.696 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015159 psu
2023-05-16T19:28:41.699Z,1684265321.699 [CTD_Seabird](ERROR): Salinity reading out of range: 0.015729 psu
2023-05-16T19:28:42.704Z,1684265322.704 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013339 psu
2023-05-16T19:28:43.708Z,1684265323.708 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012601 psu
2023-05-16T19:28:44.711Z,1684265324.711 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011242 psu
2023-05-16T19:28:45.731Z,1684265325.731 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009944 psu
2023-05-16T19:28:46.735Z,1684265326.735 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009776 psu
2023-05-16T19:28:47.233Z,1684265327.233 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20230516T185322/Courier0016.lzma
2023-05-16T19:28:47.739Z,1684265327.739 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009945 psu
2023-05-16T19:28:48.235Z,1684265328.235 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Courier0016.lzma.bak
2023-05-16T19:28:48.235Z,1684265328.235 [DataOverHttps](INFO): SBD MOMSN=18317360
2023-05-16T19:28:48.743Z,1684265328.743 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009214 psu
2023-05-16T19:28:49.748Z,1684265329.748 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009158 psu
2023-05-16T19:28:50.751Z,1684265330.751 [CTD_Seabird](ERROR): Salinity reading out of range: 0.009102 psu
2023-05-16T19:28:51.756Z,1684265331.756 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008933 psu
2023-05-16T19:28:52.759Z,1684265332.759 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008765 psu
2023-05-16T19:28:53.764Z,1684265333.764 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008597 psu
2023-05-16T19:28:54.767Z,1684265334.767 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008485 psu
2023-05-16T19:28:55.780Z,1684265335.780 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008485 psu
2023-05-16T19:28:56.783Z,1684265336.783 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008429 psu
2023-05-16T19:28:57.788Z,1684265337.788 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008373 psu
2023-05-16T19:28:58.792Z,1684265338.792 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008261 psu
2023-05-16T19:28:59.796Z,1684265339.796 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008205 psu
2023-05-16T19:29:00.799Z,1684265340.799 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008149 psu
2023-05-16T19:29:01.804Z,1684265341.804 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008093 psu
2023-05-16T19:29:02.808Z,1684265342.808 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007982 psu
2023-05-16T19:29:03.812Z,1684265343.812 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007870 psu
2023-05-16T19:29:04.782Z,1684265344.782 [DataOverHttps](INFO): Sending 259 bytes from file Logs/20230516T185322/Express0017.lzma
2023-05-16T19:29:04.815Z,1684265344.815 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007814 psu
2023-05-16T19:29:05.783Z,1684265345.783 [DataOverHttps](INFO): Moved sent file to Logs/20230516T185322/Express0017.lzma.bak
2023-05-16T19:29:05.783Z,1684265345.783 [DataOverHttps](INFO): SBD MOMSN=18317390
2023-05-16T19:29:05.820Z,1684265345.820 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007647 psu
2023-05-16T19:29:06.823Z,1684265346.823 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007702 psu
2023-05-16T19:29:07.473Z,1684265347.473 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped
2023-05-16T19:29:07.473Z,1684265347.473 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1
2023-05-16T19:29:07.473Z,1684265347.473 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-05-16T19:29:07.828Z,1684265347.828 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007646 psu
2023-05-16T19:29:08.831Z,1684265348.831 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007535 psu
2023-05-16T19:29:09.836Z,1684265349.836 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007535 psu
2023-05-16T19:29:10.839Z,1684265350.839 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007479 psu
2023-05-16T19:29:11.843Z,1684265351.843 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007423 psu
2023-05-16T19:29:12.847Z,1684265352.847 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007368 psu
2023-05-16T19:29:13.852Z,1684265353.852 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007312 psu
2023-05-16T19:29:14.855Z,1684265354.855 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007256 psu
2023-05-16T19:29:15.859Z,1684265355.859 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007201 psu
2023-05-16T19:29:16.863Z,1684265356.863 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007200 psu
2023-05-16T19:29:17.867Z,1684265357.867 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007145 psu
2023-05-16T19:29:18.871Z,1684265358.871 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007089 psu
2023-05-16T19:29:19.875Z,1684265359.875 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007255 psu
2023-05-16T19:29:20.879Z,1684265360.879 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007033 psu
2023-05-16T19:29:21.883Z,1684265361.883 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006978 psu
2023-05-16T19:29:22.887Z,1684265362.887 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006922 psu
2023-05-16T19:29:23.891Z,1684265363.891 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006922 psu
2023-05-16T19:29:24.895Z,1684265364.895 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006866 psu
2023-05-16T19:29:25.899Z,1684265365.899 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006866 psu
2023-05-16T19:29:26.903Z,1684265366.903 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006811 psu
2023-05-16T19:29:27.907Z,1684265367.907 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006755 psu
2023-05-16T19:29:28.911Z,1684265368.911 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006700 psu
2023-05-16T19:29:29.915Z,1684265369.915 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006699 psu
2023-05-16T19:29:30.919Z,1684265370.919 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006644 psu
2023-05-16T19:29:31.923Z,1684265371.923 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006644 psu
2023-05-16T19:29:32.928Z,1684265372.928 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006588 psu
2023-05-16T19:29:33.931Z,1684265373.931 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006588 psu
2023-05-16T19:29:34.935Z,1684265374.935 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006533 psu
2023-05-16T19:29:35.940Z,1684265375.940 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006532 psu
2023-05-16T19:29:36.943Z,1684265376.943 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006477 psu
2023-05-16T19:29:37.947Z,1684265377.947 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006422 psu
2023-05-16T19:29:38.970Z,1684265378.970 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006421 psu
2023-05-16T19:29:39.967Z,1684265379.967 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006421 psu
2023-05-16T19:29:40.979Z,1684265380.979 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006366 psu
2023-05-16T19:29:41.983Z,1684265381.983 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006365 psu
2023-05-16T19:29:42.987Z,1684265382.987 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006365 psu
2023-05-16T19:29:43.996Z,1684265383.996 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006420 psu
2023-05-16T19:29:44.996Z,1684265384.996 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006695 psu
2023-05-16T19:29:45.000Z,1684265386.000 [CTD_Seabird](ERROR): Salinity reading out of range: 0.006640 psu
2023-05-16T19:29:47.003Z,1684265387.003 [CTD_Seabird](ERROR): Salinity reading out of range: 0.008474 psu
2023-05-16T19:29:48.008Z,1684265388.008 [CTD_Seabird](ERROR): Salinity reading out of range: 0.007637 psu
2023-05-16T19:29:49.011Z,1684265389.011 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010156 psu
2023-05-16T19:29:50.015Z,1684265390.015 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012641 psu
2023-05-16T19:29:51.019Z,1684265391.019 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010888 psu
2023-05-16T19:29:52.023Z,1684265392.023 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010831 psu
2023-05-16T19:29:53.027Z,1684265393.027 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012187 psu
2023-05-16T19:29:54.031Z,1684265394.031 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012299 psu
2023-05-16T19:29:55.035Z,1684265395.035 [CTD_Seabird](ERROR): Salinity reading out of range: 0.013659 psu
2023-05-16T19:29:56.039Z,1684265396.039 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012807 psu
2023-05-16T19:29:57.043Z,1684265397.043 [CTD_Seabird](ERROR): Salinity reading out of range: 0.012127 psu
2023-05-16T19:29:58.048Z,1684265398.048 [CTD_Seabird](ERROR): Salinity reading out of range: 0.011561 psu
2023-05-16T19:29:58.618Z,1684265398.618 [CommandExec](IMPORTANT): got command quit
2023-05-16T19:29:59.051Z,1684265399.051 [CTD_Seabird](ERROR): Salinity reading out of range: 0.010488 psu
2023-05-16T19:29:59.621Z,1684265399.621 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2023-05-16T19:29:59.622Z,1684265399.622 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:29:59.622Z,1684265399.622 [CommandExec](INFO): Uninitializing the command executive.
2023-05-16T19:29:59.622Z,1684265399.622 [CommandExec](INFO): Uninitializing the command scheduler.
2023-05-16T19:29:59.622Z,1684265399.622 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:29:59.721Z,1684265399.721 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-05-16T19:29:59.721Z,1684265399.721 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-05-16T19:29:59.721Z,1684265399.721 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:29:59.722Z,1684265399.722 [NavChartDb](INFO): Join timeout helper Thread ID is 8397
2023-05-16T19:29:59.994Z,1684265399.994 [MissionManager](INFO): MissionManager is completed.
2023-05-16T19:29:59.995Z,1684265399.995 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface] Stopped
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science] Stopped
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science:B] Stopped
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science:C] Stopped
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science:E] Stopped
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science:OceanCurrent] Stopped
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped
2023-05-16T19:29:59.995Z,1684265399.995 [run_backseat_on_surface:B.BackseatDriver] Stopped
2023-05-16T19:29:59.996Z,1684265399.996 [run_backseat_on_surface:B.BackseatDriver](DEBUG): Uninitialize.
2023-05-16T19:29:59.996Z,1684265399.996 [run_backseat_on_surface:C.GoToSurface] Stopped
2023-05-16T19:29:59.996Z,1684265399.996 [run_backseat_on_surface:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T19:29:59.996Z,1684265399.996 [run_backseat_on_surface:CheckIn] Stopped
2023-05-16T19:29:59.996Z,1684265399.996 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2023-05-16T19:29:59.996Z,1684265399.996 [run_backseat_on_surface:CheckIn:C.Wait] Stopped
2023-05-16T19:29:59.996Z,1684265399.996 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T19:30:00.102Z,1684265400.102 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:00.102Z,1684265400.102 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:00.113Z,1684265400.113 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-05-16T19:30:00.113Z,1684265400.113 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:00.114Z,1684265400.114 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8398
2023-05-16T19:30:00.157Z,1684265400.157 [WetLabsBB2FL](INFO): Powering down
2023-05-16T19:30:00.158Z,1684265400.158 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:00.159Z,1684265400.159 [WetLabsBB2FL](INFO): Powering down
2023-05-16T19:30:00.159Z,1684265400.159 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:00.173Z,1684265400.173 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-05-16T19:30:00.174Z,1684265400.174 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:00.174Z,1684265400.174 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8399
2023-05-16T19:30:00.401Z,1684265400.401 [MissionManager](IMPORTANT): Started mission Default
2023-05-16T19:30:00.401Z,1684265400.401 [Default] Running Loop=1
2023-05-16T19:30:00.401Z,1684265400.401 [Default](DEBUG): Aggregate::initialize Default
2023-05-16T19:30:00.401Z,1684265400.401 [Default:B.GoToSurface] Running Loop=1
2023-05-16T19:30:00.401Z,1684265400.401 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-05-16T19:30:00.402Z,1684265400.402 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-05-16T19:30:00.402Z,1684265400.402 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-05-16T19:30:00.402Z,1684265400.402 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-05-16T19:30:00.403Z,1684265400.403 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-05-16T19:30:00.403Z,1684265400.403 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-05-16T19:30:00.404Z,1684265400.404 [Default:A.Wait] Running Loop=1
2023-05-16T19:30:00.404Z,1684265400.404 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-05-16T19:30:00.545Z,1684265400.545 [BackseatComponent](INFO): Sent LCM shutdown request.
2023-05-16T19:30:01.058Z,1684265401.058 [CTD_Seabird](INFO): Powering down
2023-05-16T19:30:01.193Z,1684265401.193 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:01.194Z,1684265401.194 [CTD_Seabird](INFO): Powering down
2023-05-16T19:30:01.205Z,1684265401.205 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:01.221Z,1684265401.221 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-05-16T19:30:01.221Z,1684265401.221 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:01.222Z,1684265401.222 [Radio_Surface](INFO): Join timeout helper Thread ID is 8400
2023-05-16T19:30:01.301Z,1684265401.301 [Radio_Surface](INFO): Powering down
2023-05-16T19:30:01.302Z,1684265401.302 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:01.302Z,1684265401.302 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:01.322Z,1684265401.322 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-05-16T19:30:01.322Z,1684265401.322 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:01.323Z,1684265401.323 [Onboard](INFO): Join timeout helper Thread ID is 8401
2023-05-16T19:30:01.605Z,1684265401.605 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-05-16T19:30:04.533Z,1684265404.533 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:04.534Z,1684265404.534 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.547Z,1684265404.547 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-05-16T19:30:04.547Z,1684265404.547 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.548Z,1684265404.548 [DataOverHttps](INFO): Join timeout helper Thread ID is 8402
2023-05-16T19:30:04.617Z,1684265404.617 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:04.618Z,1684265404.618 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.622Z,1684265404.622 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-05-16T19:30:04.622Z,1684265404.622 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.622Z,1684265404.622 [BackseatComponent](INFO): Join timeout helper Thread ID is 8403
2023-05-16T19:30:04.637Z,1684265404.637 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:04.638Z,1684265404.638 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.642Z,1684265404.642 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-05-16T19:30:04.642Z,1684265404.642 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.642Z,1684265404.642 [logger](INFO): Join timeout helper Thread ID is 8404
2023-05-16T19:30:04.645Z,1684265404.645 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:04.646Z,1684265404.646 [logger ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.662Z,1684265404.662 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-05-16T19:30:04.662Z,1684265404.662 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.662Z,1684265404.662 [CommandLine](INFO): Join timeout helper Thread ID is 8405
2023-05-16T19:30:04.717Z,1684265404.717 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:04.718Z,1684265404.718 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.723Z,1684265404.723 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-05-16T19:30:04.723Z,1684265404.723 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.724Z,1684265404.724 [CommandExec](INFO): Join timeout helper Thread ID is 8406
2023-05-16T19:30:04.726Z,1684265404.726 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-05-16T19:30:04.726Z,1684265404.726 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.727Z,1684265404.727 [controlThread](INFO): Join timeout helper Thread ID is 8407
2023-05-16T19:30:04.805Z,1684265404.805 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-05-16T19:30:04.806Z,1684265404.806 [controlThread](DEBUG): Uninitializing ControlThread
2023-05-16T19:30:04.806Z,1684265404.806 [AHRS_M2](INFO): Powering down
2023-05-16T19:30:04.878Z,1684265404.878 [NAL9602](INFO): Powering down
2023-05-16T19:30:04.880Z,1684265404.880 [Waterlinked](INFO): Powering down
2023-05-16T19:30:04.881Z,1684265404.881 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-05-16T19:30:04.882Z,1684265404.882 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-05-16T19:30:04.883Z,1684265404.883 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-05-16T19:30:04.883Z,1684265404.883 [MissionManager](INFO): Uninitializing Mission Default
2023-05-16T19:30:04.883Z,1684265404.883 [Default] Stopped
2023-05-16T19:30:04.883Z,1684265404.883 [Default](DEBUG): Aggregate::uninitialize Default
2023-05-16T19:30:04.884Z,1684265404.884 [Default:A.Wait] Stopped
2023-05-16T19:30:04.884Z,1684265404.884 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-05-16T19:30:04.884Z,1684265404.884 [Default:B.GoToSurface] Stopped
2023-05-16T19:30:04.884Z,1684265404.884 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-05-16T19:30:04.887Z,1684265404.887 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-05-16T19:30:04.887Z,1684265404.887 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-05-16T19:30:04.887Z,1684265404.887 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-05-16T19:30:04.887Z,1684265404.887 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-05-16T19:30:04.888Z,1684265404.888 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-05-16T19:30:04.888Z,1684265404.888 [BuoyancyServo](INFO): Powering down
2023-05-16T19:30:04.901Z,1684265404.901 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-05-16T19:30:04.902Z,1684265404.902 [ElevatorServo](INFO): Powering down
2023-05-16T19:30:04.902Z,1684265404.902 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-05-16T19:30:04.902Z,1684265404.902 [MassServo](INFO): Powering down
2023-05-16T19:30:04.903Z,1684265404.903 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-05-16T19:30:04.903Z,1684265404.903 [RudderServo](INFO): Powering down
2023-05-16T19:30:04.904Z,1684265404.904 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-05-16T19:30:04.904Z,1684265404.904 [ThrusterHE](INFO): Powering down
2023-05-16T19:30:04.905Z,1684265404.905 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-05-16T19:30:04.906Z,1684265404.906 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-05-16T19:30:04.906Z,1684265404.906 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-05-16T19:30:04.906Z,1684265404.906 [CBIT](DEBUG): Powering off loads.
2023-05-16T19:30:04.917Z,1684265404.917 [CBIT](DEBUG): Disabling WDT.
2023-05-16T19:30:04.929Z,1684265404.929 [CBIT](DEBUG): Opening all GF detection circuits.
2023-05-16T19:30:04.930Z,1684265404.930 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.968Z,1684265404.968 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.972Z,1684265404.972 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:04.978Z,1684265404.978 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:05.020Z,1684265405.020 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:05.071Z,1684265405.071 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:05.074Z,1684265405.074 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:05.131Z,1684265405.131 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-05-16T19:30:05.176Z,1684265405.176 [logger ThreadHandler](INFO): Thread cancelled.