2025-03-11T16:28:17.888Z,1741710497.888 [Supervisor](DEBUG): Initializing supervisor.
2025-03-11T16:28:17.893Z,1741710497.893 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2025-03-11T16:28:17.893Z,1741710497.893 [SyncHandler](INFO): Protected caller Thread ID is 3540
2025-03-11T16:28:17.894Z,1741710497.894 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2025-03-11T16:28:17.895Z,1741710497.895 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2025-03-11T16:28:17.895Z,1741710497.895 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3541
2025-03-11T16:28:17.900Z,1741710497.900 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2025-03-11T16:28:17.919Z,1741710497.919 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2025-03-11T16:28:17.920Z,1741710497.920 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2025-03-11T16:28:17.920Z,1741710497.920 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3542
2025-03-11T16:28:17.924Z,1741710497.924 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2025-03-11T16:28:17.925Z,1741710497.925 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2025-03-11T16:28:17.926Z,1741710497.926 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3543
2025-03-11T16:28:17.928Z,1741710497.928 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2025-03-11T16:28:17.929Z,1741710497.929 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2025-03-11T16:28:17.929Z,1741710497.929 [logger ThreadHandler](INFO): Protected caller Thread ID is 3544
2025-03-11T16:28:17.933Z,1741710497.933 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2025-03-11T16:28:17.933Z,1741710497.933 [Supervisor](INFO): Looking for Config files in directory: Config/
2025-03-11T16:28:17.935Z,1741710497.935 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2025-03-11T16:28:18.157Z,1741710498.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2025-03-11T16:28:18.157Z,1741710498.157 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2025-03-11T16:28:18.275Z,1741710498.275 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2025-03-11T16:28:18.276Z,1741710498.276 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2025-03-11T16:28:18.382Z,1741710498.382 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2025-03-11T16:28:18.382Z,1741710498.382 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2025-03-11T16:28:18.879Z,1741710498.879 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2025-03-11T16:28:18.880Z,1741710498.880 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2025-03-11T16:28:19.257Z,1741710499.257 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2025-03-11T16:28:19.258Z,1741710499.258 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2025-03-11T16:28:19.682Z,1741710499.682 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2025-03-11T16:28:19.683Z,1741710499.683 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2025-03-11T16:28:19.992Z,1741710499.992 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2025-03-11T16:28:19.992Z,1741710499.992 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2025-03-11T16:28:20.083Z,1741710500.083 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2025-03-11T16:28:20.175Z,1741710500.175 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2025-03-11T16:28:20.599Z,1741710500.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2025-03-11T16:28:20.599Z,1741710500.599 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2025-03-11T16:28:20.900Z,1741710500.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2025-03-11T16:28:20.901Z,1741710500.901 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2025-03-11T16:28:21.467Z,1741710501.467 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2025-03-11T16:28:21.467Z,1741710501.467 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2025-03-11T16:28:21.722Z,1741710501.722 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2025-03-11T16:28:21.722Z,1741710501.722 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2025-03-11T16:28:21.978Z,1741710501.978 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2025-03-11T16:28:21.979Z,1741710501.979 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2025-03-11T16:28:22.129Z,1741710502.129 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2025-03-11T16:28:22.130Z,1741710502.130 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2025-03-11T16:28:23.006Z,1741710503.006 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2025-03-11T16:28:23.008Z,1741710503.008 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2025-03-11T16:28:23.009Z,1741710503.009 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2025-03-11T16:28:23.104Z,1741710503.104 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2025-03-11T16:28:23.243Z,1741710503.243 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2025-03-11T16:28:23.519Z,1741710503.519 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2025-03-11T16:28:23.520Z,1741710503.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2025-03-11T16:28:23.655Z,1741710503.655 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2025-03-11T16:28:23.763Z,1741710503.763 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2025-03-11T16:28:23.867Z,1741710503.867 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2025-03-11T16:28:23.986Z,1741710503.986 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2025-03-11T16:28:24.082Z,1741710504.082 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2025-03-11T16:28:24.179Z,1741710504.179 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2025-03-11T16:28:24.280Z,1741710504.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2025-03-11T16:28:24.460Z,1741710504.460 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2025-03-11T16:28:24.461Z,1741710504.461 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2025-03-11T16:28:24.471Z,1741710504.471 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2025-03-11T16:28:24.523Z,1741710504.523 [DepthRateCalculator] Loaded
2025-03-11T16:28:24.523Z,1741710504.523 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2025-03-11T16:28:24.529Z,1741710504.529 [PitchRateCalculator] Loaded
2025-03-11T16:28:24.529Z,1741710504.529 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2025-03-11T16:28:24.539Z,1741710504.539 [SpeedCalculator] Loaded
2025-03-11T16:28:24.540Z,1741710504.540 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2025-03-11T16:28:24.545Z,1741710504.545 [YawRateCalculator] Loaded
2025-03-11T16:28:24.545Z,1741710504.545 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2025-03-11T16:28:24.567Z,1741710504.567 [ElevatorOffsetCalculator] Loaded
2025-03-11T16:28:24.567Z,1741710504.567 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2025-03-11T16:28:24.567Z,1741710504.567 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2025-03-11T16:28:24.568Z,1741710504.568 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2025-03-11T16:28:24.597Z,1741710504.597 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2025-03-11T16:28:24.597Z,1741710504.597 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2025-03-11T16:28:24.608Z,1741710504.608 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2025-03-11T16:28:24.608Z,1741710504.608 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2025-03-11T16:28:25.107Z,1741710505.107 [AHRS_M2] Loaded
2025-03-11T16:28:25.107Z,1741710505.107 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2025-03-11T16:28:25.146Z,1741710505.146 [BackseatComponent] Loaded
2025-03-11T16:28:25.146Z,1741710505.146 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2025-03-11T16:28:25.147Z,1741710505.147 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408754E0
2025-03-11T16:28:25.147Z,1741710505.147 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3626
2025-03-11T16:28:25.150Z,1741710505.150 [LcmUniversalReporter] Loaded
2025-03-11T16:28:25.150Z,1741710505.150 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2025-03-11T16:28:25.945Z,1741710505.945 [BPC1] Loaded
2025-03-11T16:28:25.945Z,1741710505.945 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2025-03-11T16:28:26.041Z,1741710506.041 [DAT] Loaded
2025-03-11T16:28:26.041Z,1741710506.041 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2025-03-11T16:28:26.042Z,1741710506.042 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408A54E0
2025-03-11T16:28:26.043Z,1741710506.043 [DAT ThreadHandler](INFO): Protected caller Thread ID is 3627
2025-03-11T16:28:26.117Z,1741710506.117 [DataOverHttps] Loaded
2025-03-11T16:28:26.117Z,1741710506.117 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2025-03-11T16:28:26.118Z,1741710506.118 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408D54E0
2025-03-11T16:28:26.118Z,1741710506.118 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3628
2025-03-11T16:28:26.141Z,1741710506.141 [Depth_Keller] Loaded
2025-03-11T16:28:26.141Z,1741710506.141 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2025-03-11T16:28:26.146Z,1741710506.146 [DropWeight] Loaded
2025-03-11T16:28:26.146Z,1741710506.146 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2025-03-11T16:28:26.168Z,1741710506.168 [MultiRay](INFO): Running on single LCB
2025-03-11T16:28:26.168Z,1741710506.168 [MultiRay] Loaded
2025-03-11T16:28:26.168Z,1741710506.168 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2025-03-11T16:28:26.232Z,1741710506.232 [NAL9602] Loaded
2025-03-11T16:28:26.232Z,1741710506.232 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2025-03-11T16:28:26.262Z,1741710506.262 [Onboard] Loaded
2025-03-11T16:28:26.262Z,1741710506.262 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2025-03-11T16:28:26.263Z,1741710506.263 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409054E0
2025-03-11T16:28:26.264Z,1741710506.264 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3629
2025-03-11T16:28:26.270Z,1741710506.270 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2025-03-11T16:28:26.283Z,1741710506.283 [PowerOnly] Loaded
2025-03-11T16:28:26.283Z,1741710506.283 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2025-03-11T16:28:26.297Z,1741710506.297 [Power24vConverter] Loaded
2025-03-11T16:28:26.297Z,1741710506.297 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2025-03-11T16:28:26.314Z,1741710506.314 [Radio_Surface] Loaded
2025-03-11T16:28:26.315Z,1741710506.315 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2025-03-11T16:28:26.316Z,1741710506.316 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409354E0
2025-03-11T16:28:26.316Z,1741710506.316 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3630
2025-03-11T16:28:26.341Z,1741710506.341 [Waterlinked] Loaded
2025-03-11T16:28:26.341Z,1741710506.341 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2025-03-11T16:28:26.342Z,1741710506.342 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2025-03-11T16:28:26.342Z,1741710506.342 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2025-03-11T16:28:26.550Z,1741710506.550 [DeadReckonUsingMultipleVelocitySources] Loaded
2025-03-11T16:28:26.550Z,1741710506.550 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2025-03-11T16:28:26.573Z,1741710506.573 [NavChart] Loaded
2025-03-11T16:28:26.573Z,1741710506.573 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2025-03-11T16:28:26.629Z,1741710506.629 [UniversalFixResidualReporter] Loaded
2025-03-11T16:28:26.630Z,1741710506.630 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2025-03-11T16:28:26.637Z,1741710506.637 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2025-03-11T16:28:26.637Z,1741710506.637 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2025-03-11T16:28:27.026Z,1741710507.026 [SBIT](DEBUG): Construct Startup Built In Test.
2025-03-11T16:28:27.040Z,1741710507.040 [SBIT] Loaded
2025-03-11T16:28:27.040Z,1741710507.040 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2025-03-11T16:28:27.043Z,1741710507.043 [IBIT](DEBUG): Construct Initiated Built In Test.
2025-03-11T16:28:27.056Z,1741710507.056 [IBIT] Loaded
2025-03-11T16:28:27.057Z,1741710507.057 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2025-03-11T16:28:27.062Z,1741710507.062 [CBIT](DEBUG): Construct Continuous Built In Test.
2025-03-11T16:28:27.255Z,1741710507.255 [CBIT] Loaded
2025-03-11T16:28:27.255Z,1741710507.255 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2025-03-11T16:28:27.287Z,1741710507.287 [GFScanner] Loaded
2025-03-11T16:28:27.287Z,1741710507.287 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread.
2025-03-11T16:28:27.287Z,1741710507.287 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2025-03-11T16:28:27.288Z,1741710507.288 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2025-03-11T16:28:27.456Z,1741710507.456 [CTD_Seabird] Loaded
2025-03-11T16:28:27.456Z,1741710507.456 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2025-03-11T16:28:27.457Z,1741710507.457 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A474E0
2025-03-11T16:28:27.457Z,1741710507.457 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3631
2025-03-11T16:28:27.480Z,1741710507.480 [PAR_Licor] Loaded
2025-03-11T16:28:27.480Z,1741710507.480 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2025-03-11T16:28:27.526Z,1741710507.526 [WetLabsBB2FL] Loaded
2025-03-11T16:28:27.526Z,1741710507.526 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2025-03-11T16:28:27.527Z,1741710507.527 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0
2025-03-11T16:28:27.528Z,1741710507.528 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3632
2025-03-11T16:28:27.529Z,1741710507.529 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2025-03-11T16:28:27.529Z,1741710507.529 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2025-03-11T16:28:27.667Z,1741710507.667 [BuoyancyServo] Loaded
2025-03-11T16:28:27.668Z,1741710507.668 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2025-03-11T16:28:27.692Z,1741710507.692 [ElevatorServo] Loaded
2025-03-11T16:28:27.692Z,1741710507.692 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2025-03-11T16:28:27.715Z,1741710507.715 [MassServo] Loaded
2025-03-11T16:28:27.716Z,1741710507.716 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2025-03-11T16:28:27.738Z,1741710507.738 [RudderServo] Loaded
2025-03-11T16:28:27.738Z,1741710507.738 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2025-03-11T16:28:27.756Z,1741710507.756 [ThrusterHE] Loaded
2025-03-11T16:28:27.757Z,1741710507.757 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2025-03-11T16:28:27.757Z,1741710507.757 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2025-03-11T16:28:27.758Z,1741710507.758 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2025-03-11T16:28:27.811Z,1741710507.811 [VerticalControl](DEBUG): Construct VerticalControl.
2025-03-11T16:28:27.863Z,1741710507.863 [VerticalControl] Loaded
2025-03-11T16:28:27.863Z,1741710507.863 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2025-03-11T16:28:27.866Z,1741710507.866 [HorizontalControl](DEBUG): Construct HorizontalControl.
2025-03-11T16:28:27.910Z,1741710507.910 [HorizontalControl] Loaded
2025-03-11T16:28:27.910Z,1741710507.910 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2025-03-11T16:28:27.913Z,1741710507.913 [SpeedControl](DEBUG): Construct SpeedControl.
2025-03-11T16:28:27.915Z,1741710507.915 [SpeedControl] Loaded
2025-03-11T16:28:27.915Z,1741710507.915 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2025-03-11T16:28:27.918Z,1741710507.918 [LoopControl](DEBUG): Construct LoopControl.
2025-03-11T16:28:27.919Z,1741710507.919 [LoopControl] Loaded
2025-03-11T16:28:27.919Z,1741710507.919 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2025-03-11T16:28:27.919Z,1741710507.919 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2025-03-11T16:28:27.920Z,1741710507.920 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2025-03-11T16:28:28.052Z,1741710508.052 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2025-03-11T16:28:28.052Z,1741710508.052 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2025-03-11T16:28:28.230Z,1741710508.230 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2025-03-11T16:28:28.230Z,1741710508.230 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2025-03-11T16:28:28.577Z,1741710508.577 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2025-03-11T16:28:28.578Z,1741710508.578 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2025-03-11T16:28:28.636Z,1741710508.636 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2025-03-11T16:28:28.643Z,1741710508.643 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2025-03-11T16:28:28.646Z,1741710508.646 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2025-03-11T16:28:28.657Z,1741710508.657 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2025-03-11T16:28:28.658Z,1741710508.658 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C654E0
2025-03-11T16:28:28.659Z,1741710508.659 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3633
2025-03-11T16:28:28.663Z,1741710508.663 [Supervisor](INFO): Main Thread ID is 3401
2025-03-11T16:28:28.663Z,1741710508.663 [Supervisor](DEBUG): Running supervisor.
2025-03-11T16:28:28.664Z,1741710508.664 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3634
2025-03-11T16:28:28.664Z,1741710508.664 [CommandExec](INFO): Initializing the command executive.
2025-03-11T16:28:28.666Z,1741710508.666 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3635
2025-03-11T16:28:28.668Z,1741710508.668 [controlThread ThreadHandler](INFO): Handler Thread ID is 3636
2025-03-11T16:28:28.669Z,1741710508.669 [controlThread](DEBUG): Initializing ControlThread
2025-03-11T16:28:28.670Z,1741710508.670 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2025-03-11T16:28:28.670Z,1741710508.670 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2025-03-11T16:28:28.671Z,1741710508.671 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2025-03-11T16:28:28.671Z,1741710508.671 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2025-03-11T16:28:28.671Z,1741710508.671 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2025-03-11T16:28:28.676Z,1741710508.676 [NavChart](DEBUG): Initialize NavChart Navigation.
2025-03-11T16:28:28.677Z,1741710508.677 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2025-03-11T16:28:28.677Z,1741710508.677 [SBIT](INFO): Initialize SBIT Component.
2025-03-11T16:28:28.678Z,1741710508.678 [SBIT](IMPORTANT): git: 2025-03-10
2025-03-11T16:28:28.678Z,1741710508.678 [SBIT](INFO): git hash: ed984fb97dc40cbcfe09dec37ea56a9b8070d839
2025-03-11T16:28:28.678Z,1741710508.678 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2025-03-11T16:28:28.680Z,1741710508.680 [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
2025-03-11T16:28:28.681Z,1741710508.681 [SBIT](INFO): Beginning SBIT in 59.000000 seconds.
2025-03-11T16:28:28.681Z,1741710508.681 [IBIT](INFO): Initialize IBIT Component.
2025-03-11T16:28:28.682Z,1741710508.682 [CBIT](DEBUG): Initialize CBIT Component.
2025-03-11T16:28:28.683Z,1741710508.683 [logger ThreadHandler](INFO): Handler Thread ID is 3637
2025-03-11T16:28:28.693Z,1741710508.693 [CBIT](DEBUG): Initialized mux pins.
2025-03-11T16:28:28.693Z,1741710508.693 [CBIT](DEBUG): Initializing the watchdog timer.
2025-03-11T16:28:28.702Z,1741710508.702 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3638
2025-03-11T16:28:28.714Z,1741710508.714 [DAT ThreadHandler](INFO): Handler Thread ID is 3639
2025-03-11T16:28:28.714Z,1741710508.714 [DAT](INFO): Powering up
2025-03-11T16:28:28.714Z,1741710508.714 [DAT](DEBUG): Initializing DAT.
2025-03-11T16:28:28.717Z,1741710508.717 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2025-03-11T16:28:28.718Z,1741710508.718 [CBIT](DEBUG): Initializing heartbeat.
2025-03-11T16:28:28.719Z,1741710508.719 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3641
2025-03-11T16:28:28.721Z,1741710508.721 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2025-03-11T16:28:28.730Z,1741710508.730 [Onboard ThreadHandler](INFO): Handler Thread ID is 3642
2025-03-11T16:28:28.760Z,1741710508.760 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3643
2025-03-11T16:28:28.777Z,1741710508.777 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3644
2025-03-11T16:28:28.778Z,1741710508.778 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2025-03-11T16:28:28.782Z,1741710508.782 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3646
2025-03-11T16:28:28.786Z,1741710508.786 [WetLabsBB2FL](INFO): Powering up
2025-03-11T16:28:28.787Z,1741710508.787 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3648
2025-03-11T16:28:28.789Z,1741710508.789 [CBIT](DEBUG): Deactivating emergency mode.
2025-03-11T16:28:28.790Z,1741710508.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2025-03-11T16:28:28.790Z,1741710508.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2025-03-11T16:28:28.790Z,1741710508.790 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2025-03-11T16:28:28.790Z,1741710508.790 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2025-03-11T16:28:28.791Z,1741710508.791 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2025-03-11T16:28:28.791Z,1741710508.791 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2025-03-11T16:28:28.791Z,1741710508.791 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2025-03-11T16:28:28.791Z,1741710508.791 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2025-03-11T16:28:28.829Z,1741710508.829 [CBIT](DEBUG): Backplane powered.
2025-03-11T16:28:28.829Z,1741710508.829 [GFScanner](DEBUG): Initializing GFScanner
2025-03-11T16:28:28.830Z,1741710508.830 [GFScanner](DEBUG): Deactivating GF circuits.
2025-03-11T16:28:28.839Z,1741710508.839 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2025-03-11T16:28:28.840Z,1741710508.840 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2025-03-11T16:28:28.841Z,1741710508.841 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2025-03-11T16:28:28.842Z,1741710508.842 [LoopControl](DEBUG): Initialize LoopControlComponent.
2025-03-11T16:28:28.842Z,1741710508.842 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2025-03-11T16:28:28.843Z,1741710508.843 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2025-03-11T16:28:28.843Z,1741710508.843 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2025-03-11T16:28:28.844Z,1741710508.844 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2025-03-11T16:28:28.900Z,1741710508.900 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2025-03-11T16:28:28.904Z,1741710508.904 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2025-03-11T16:28:28.933Z,1741710508.933 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2025-03-11T16:28:28.945Z,1741710508.945 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2025-03-11T16:28:28.946Z,1741710508.946 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2025-03-11T16:28:28.947Z,1741710508.947 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2025-03-11T16:28:29.161Z,1741710509.161 [Radio_Surface](INFO): Powering up
2025-03-11T16:28:29.184Z,1741710509.184 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2025-03-11T16:28:29.189Z,1741710509.189 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2025-03-11T16:28:29.191Z,1741710509.191 [Default:A.Wait](DEBUG): Construct Wait.
2025-03-11T16:28:29.205Z,1741710509.205 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-03-11T16:28:29.233Z,1741710509.233 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-03-11T16:28:29.236Z,1741710509.236 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-03-11T16:28:29.242Z,1741710509.242 [Default:E.Execute](DEBUG): Construct Execute.
2025-03-11T16:28:29.245Z,1741710509.245 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2025-03-11T16:28:29.250Z,1741710509.250 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter,
2025-03-11T16:28:29.265Z,1741710509.265 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2025-03-11T16:28:29.316Z,1741710509.316 [MultiRay](INFO): Powering up MultiRay Lights
2025-03-11T16:28:29.334Z,1741710509.334 [Power24vConverter](INFO): Powering up.
2025-03-11T16:28:29.371Z,1741710509.371 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2025-03-11T16:28:29.377Z,1741710509.377 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2025-03-11T16:28:29.378Z,1741710509.378 [ElevatorServo](DEBUG): Initializing EZServoServo.
2025-03-11T16:28:29.385Z,1741710509.385 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2025-03-11T16:28:29.386Z,1741710509.386 [MassServo](DEBUG): Initializing EZServoServo.
2025-03-11T16:28:29.393Z,1741710509.393 [MassServo](DEBUG): Initializing MassServo.
2025-03-11T16:28:29.394Z,1741710509.394 [RudderServo](DEBUG): Initializing EZServoServo.
2025-03-11T16:28:29.401Z,1741710509.401 [RudderServo](DEBUG): Initializing RudderServo.
2025-03-11T16:28:29.402Z,1741710509.402 [ThrusterHE](DEBUG): Initializing EZServoServo.
2025-03-11T16:28:29.409Z,1741710509.409 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2025-03-11T16:28:31.401Z,1741710511.401 [WetLabsBB2FL](INFO): Powering down
2025-03-11T16:28:35.810Z,1741710515.810 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2025-03-11T16:28:41.326Z,1741710521.326 [DAT](INFO): DAT read:
2025-03-11T16:28:41.327Z,1741710521.327 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2025-03-11T16:28:43.099Z,1741710523.099 [DAT](INFO): DAT read: MF Frequency Band
2025-03-11T16:28:43.100Z,1741710523.100 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2025-03-11T16:28:43.101Z,1741710523.101 [DAT](INFO): DAT read: Mar 10 2025 16:17:30
2025-03-11T16:28:44.358Z,1741710524.358 [DAT](INFO): DAT read: Features enabled [Bearing]
2025-03-11T16:28:44.360Z,1741710524.360 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2025-03-11T16:28:44.360Z,1741710524.360 [DAT](INFO): commRate: 800
2025-03-11T16:28:46.425Z,1741710526.425 [DAT](INFO): entering command mode
2025-03-11T16:28:46.627Z,1741710526.627 [DAT](INFO): DAT read:
2025-03-11T16:28:46.628Z,1741710526.628 [DAT](INFO): DAT read: user:1>
2025-03-11T16:28:46.628Z,1741710526.628 [DAT](INFO): setting verbose to 3
2025-03-11T16:28:46.878Z,1741710526.878 [DAT](INFO): DAT read: user:1>
2025-03-11T16:28:46.879Z,1741710526.879 [DAT](INFO): DAT read: Verbose | 3
2025-03-11T16:28:46.879Z,1741710526.879 [DAT](INFO): set verbose to 3
2025-03-11T16:28:46.880Z,1741710526.880 [DAT](INFO): setting DatVerbose to 27440
2025-03-11T16:28:47.130Z,1741710527.130 [DAT](INFO): DAT read: user:2>
2025-03-11T16:28:47.131Z,1741710527.131 [DAT](INFO): DAT read: DatVerbose | 27440
2025-03-11T16:28:47.131Z,1741710527.131 [DAT](INFO): set DatVerbose to 27440
2025-03-11T16:28:47.131Z,1741710527.131 [DAT](INFO): setting transmit power to 8
2025-03-11T16:28:47.382Z,1741710527.382 [DAT](INFO): DAT read: user:3>
2025-03-11T16:28:47.383Z,1741710527.383 [DAT](INFO): DAT read: TxPower | 8 (Max)
2025-03-11T16:28:47.383Z,1741710527.383 [DAT](INFO): set transmit power to 8
2025-03-11T16:28:47.383Z,1741710527.383 [DAT](INFO): setting local address to 9
2025-03-11T16:28:47.634Z,1741710527.634 [DAT](INFO): DAT read: user:4>
2025-03-11T16:28:47.635Z,1741710527.635 [DAT](INFO): DAT read: LocalAddr | 9
2025-03-11T16:28:47.635Z,1741710527.635 [DAT](INFO): set local address to 9
2025-03-11T16:28:47.636Z,1741710527.636 [DAT](INFO): Setting time to: 16:28:47 And date to:3/11/2025
2025-03-11T16:28:47.886Z,1741710527.886 [DAT](INFO): DAT read: user:5>
2025-03-11T16:28:47.887Z,1741710527.887 [DAT](INFO): DAT read: Tue Mar 11, 2025 16:28:47
2025-03-11T16:28:47.887Z,1741710527.887 [DAT](INFO): Local DAT time set to Tue Mar 11, 2025 16:28:47
2025-03-11T16:28:56.335Z,1741710536.335 [NAL9602](INFO): Powering up NAL9602
2025-03-11T16:29:05.709Z,1741710545.709 [Waterlinked](INFO): Powering down
2025-03-11T16:29:07.243Z,1741710547.243 [NAL9602](INFO): NAL9602 initialized
2025-03-11T16:29:28.264Z,1741710568.264 [SBIT](IMPORTANT): Beginning Startup BIT
2025-03-11T16:29:28.268Z,1741710568.268 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-03-11T16:29:32.809Z,1741710572.809 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.010312
CHAN A1 (24V): 0.000807
CHAN A2 (12V): -0.005187
CHAN A3 (5V): -0.003445
CHAN B0 (3.3V): -0.001322
CHAN B1 (3.15aV): -0.001114
CHAN B2 (3.15bV): -0.001615
CHAN B3 (GND): -0.000992
OPEN: 0.004540
Full Scale: +/- 1 mA
2025-03-11T16:30:12.806Z,1741710612.806 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:30:22.478Z,1741710622.478 [SBIT](IMPORTANT): SBIT PASSED
2025-03-11T16:30:22.479Z,1741710622.479 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2025-03-11T16:30:22.479Z,1741710622.479 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 15.000000 meter;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 10.000000 meter;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): GFScanner.loadAtStartup=1 bool;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): GFScanner.simulateHardware=0 bool;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=1 bool;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=0 bool;
2025-03-11T16:30:22.480Z,1741710622.480 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=277.341836 cubic_centimeter;
2025-03-11T16:30:22.481Z,1741710622.481 [SBIT](IMPORTANT): VerticalControl.massDefault=9.807535 millimeter;
2025-03-11T16:30:22.895Z,1741710622.895 [MissionManager](IMPORTANT): Started mission Startup
2025-03-11T16:30:22.896Z,1741710622.896 [Startup] Running Loop=1
2025-03-11T16:30:22.896Z,1741710622.896 [Startup](DEBUG): Aggregate::initialize Startup
2025-03-11T16:30:22.896Z,1741710622.896 [Startup:A.GoToSurface] Running Loop=1
2025-03-11T16:30:22.896Z,1741710622.896 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-11T16:30:22.896Z,1741710622.896 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-11T16:30:22.897Z,1741710622.897 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-11T16:30:22.897Z,1741710622.897 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-11T16:30:22.898Z,1741710622.898 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-11T16:30:22.898Z,1741710622.898 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-11T16:30:22.898Z,1741710622.898 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-11T16:30:22.900Z,1741710622.900 [Startup:StartupSatComms] Running Loop=1
2025-03-11T16:30:22.900Z,1741710622.900 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2025-03-11T16:30:22.900Z,1741710622.900 [Startup:StartupSatComms:A] Running Loop=1
2025-03-11T16:30:23.303Z,1741710623.303 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2025-03-11T16:30:30.989Z,1741710630.989 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:30:43.109Z,1741710643.109 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:30:56.632Z,1741710656.632 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005287
2025-03-11T16:31:23.067Z,1741710683.067 [Startup:StartupSatComms:A](INFO): Timed out from 2025-03-11T16:30:22.9Z
2025-03-11T16:31:23.067Z,1741710683.067 [Startup:StartupSatComms:A] Stopped
2025-03-11T16:31:23.067Z,1741710683.067 [Startup:StartupSatComms:B] Running Loop=1
2025-03-11T16:31:23.471Z,1741710683.471 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-03-11T16:31:28.004Z,1741710688.004 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:31:28.742Z,1741710688.742 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-03-11T16:31:28.742Z,1741710688.742 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:31:28.790Z,1741710688.790 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:31:29.159Z,1741710689.159 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:31:29.159Z,1741710689.159 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-03-11T16:31:30.213Z,1741710690.213 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250311T162430/Courier0004.lzma
2025-03-11T16:31:31.215Z,1741710691.215 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162430/Courier0004.lzma.bak
2025-03-11T16:31:31.215Z,1741710691.215 [DataOverHttps](INFO): SBD MOMSN=24176416
2025-03-11T16:31:52.345Z,1741710712.345 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250311T162817/Courier0000.lzma
2025-03-11T16:31:53.347Z,1741710713.347 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Courier0000.lzma.bak
2025-03-11T16:31:53.347Z,1741710713.347 [DataOverHttps](INFO): SBD MOMSN=24176418
2025-03-11T16:32:09.117Z,1741710729.117 [DataOverHttps](INFO): Sending 142 bytes from file Logs/20250311T162430/Express0005.lzma
2025-03-11T16:32:10.119Z,1741710730.119 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162430/Express0005.lzma.bak
2025-03-11T16:32:10.119Z,1741710730.119 [DataOverHttps](INFO): SBD MOMSN=24176421
2025-03-11T16:32:23.348Z,1741710743.348 [Startup:StartupSatComms:B](INFO): Timed out from 2025-03-11T16:31:23.1Z
2025-03-11T16:32:23.348Z,1741710743.348 [Startup:StartupSatComms:B] Stopped
2025-03-11T16:32:23.348Z,1741710743.348 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2025-03-11T16:32:23.348Z,1741710743.348 [Startup:StartupSatComms] Stopped
2025-03-11T16:32:23.348Z,1741710743.348 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2025-03-11T16:32:23.353Z,1741710743.353 [Startup](INFO): Completed Startup
2025-03-11T16:32:23.354Z,1741710743.354 [MissionManager](INFO): Startup is completed.
2025-03-11T16:32:23.354Z,1741710743.354 [MissionManager](INFO): Uninitializing Mission Startup
2025-03-11T16:32:23.354Z,1741710743.354 [Startup] Stopped
2025-03-11T16:32:23.354Z,1741710743.354 [Startup](DEBUG): Aggregate::uninitialize Startup
2025-03-11T16:32:23.354Z,1741710743.354 [Startup:A.GoToSurface] Stopped
2025-03-11T16:32:23.354Z,1741710743.354 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-11T16:32:23.727Z,1741710743.727 [MissionManager](IMPORTANT): Started mission Default
2025-03-11T16:32:23.727Z,1741710743.727 [Default] Running Loop=1
2025-03-11T16:32:23.728Z,1741710743.728 [Default](DEBUG): Aggregate::initialize Default
2025-03-11T16:32:23.728Z,1741710743.728 [Default:B.GoToSurface] Running Loop=1
2025-03-11T16:32:23.728Z,1741710743.728 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-11T16:32:23.728Z,1741710743.728 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-11T16:32:23.728Z,1741710743.728 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-11T16:32:23.729Z,1741710743.729 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-11T16:32:23.733Z,1741710743.733 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-11T16:32:23.733Z,1741710743.733 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-11T16:32:23.734Z,1741710743.734 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-11T16:32:23.734Z,1741710743.734 [Default:A.Wait] Running Loop=1
2025-03-11T16:32:23.734Z,1741710743.734 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-03-11T16:32:24.626Z,1741710744.626 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:32:26.047Z,1741710746.047 [DataOverHttps](INFO): Sending 860 bytes from file Logs/20250311T162817/Express0001.lzma
2025-03-11T16:32:27.047Z,1741710747.047 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Express0001.lzma.bak
2025-03-11T16:32:27.047Z,1741710747.047 [DataOverHttps](INFO): SBD MOMSN=24176425
2025-03-11T16:32:37.056Z,1741710757.056 [Default:A.Wait](INFO): Done Waiting.
2025-03-11T16:32:37.056Z,1741710757.056 [Default:A.Wait] Stopped
2025-03-11T16:32:37.056Z,1741710757.056 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T16:32:37.464Z,1741710757.464 [Default:CheckIn] Running Loop=1
2025-03-11T16:32:37.465Z,1741710757.464 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-03-11T16:32:37.465Z,1741710757.465 [Default:CheckIn:Read_GPS] Running Loop=1
2025-03-11T16:32:37.888Z,1741710757.888 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-03-11T16:34:10.373Z,1741710850.373 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-03-11T16:34:21.763Z,1741710861.763 [DataOverHttps](IMPORTANT): SBD MTMSN=20250311T163420
2025-03-11T16:34:29.109Z,1741710869.109 [DataOverHttps](INFO): Received command: load Engineering/lab_test_optim.tl;set lab_test_optim.RecordTime 10 min;run
2025-03-11T16:34:29.179Z,1741710869.179 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/lab_test_optim.tl
2025-03-11T16:34:29.179Z,1741710869.179 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/lab_test_optim.tl
2025-03-11T16:34:29.179Z,1741710869.179 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/lab_test_optim.tl
2025-03-11T16:34:29.181Z,1741710869.181 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/lab_test_optim.tl
2025-03-11T16:34:29.476Z,1741710869.476 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/lab_test_optim.tl translated into:
15
1
30
2
100
100
Waiting
for backseat to start up...
Trying to run Optim and Multiray forreal
1
Setting multiray red brightness to
2
Setting muliray white brightness to
Recording for
2025-03-11T16:34:29.494Z,1741710869.494 [MissionManager](INFO): DefineArg lab_test_optim.MissionTimeout = 15.000000 min
2025-03-11T16:34:29.497Z,1741710869.497 [MissionManager](INFO): DefineArg lab_test_optim.RecordTime = 1.000000 min
2025-03-11T16:34:29.500Z,1741710869.500 [MissionManager](INFO): DefineArg lab_test_optim.BackseatWait = 30.000000 s
2025-03-11T16:34:29.503Z,1741710869.503 [MissionManager](INFO): DefineArg lab_test_optim.LightMode = 2.000000 count
2025-03-11T16:34:29.506Z,1741710869.506 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessWhite = 100.000000 n/a int32
2025-03-11T16:34:29.510Z,1741710869.510 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessRed = 100.000000 n/a int32
2025-03-11T16:34:29.512Z,1741710869.512 [MissionManager](INFO): DefineOutput lab_test_optim.RecordingEnabled = 0 bool
2025-03-11T16:34:29.515Z,1741710869.515 [MissionManager](INFO): DefineOutput lab_test_optim.LightsEnabled = 0 bool
2025-03-11T16:34:29.516Z,1741710869.516 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-03-11T16:34:29.516Z,1741710869.516 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-03-11T16:34:29.517Z,1741710869.517 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-03-11T16:34:29.536Z,1741710869.536 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-03-11T16:34:29.567Z,1741710869.567 [MissionManager](INFO): DefineArg lab_test_optim:BackseatDriver.EnableBackseat = 0 bool
2025-03-11T16:34:29.582Z,1741710869.582 [lab_test_optim:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-03-11T16:34:29.610Z,1741710869.610 [lab_test_optim:Startup:B.Wait](DEBUG): Construct Wait.
2025-03-11T16:34:29.650Z,1741710869.650 [lab_test_optim:Run:H.Wait](DEBUG): Construct Wait.
2025-03-11T16:34:29.651Z,1741710869.651 [lab_test_optim:G.Wait](DEBUG): Construct Wait.
2025-03-11T16:34:29.657Z,1741710869.657 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission lab_test_optim {
arguments {
MissionTimeout = 15 minute
"""
Backseat will stay on for this duration, independent of Optim state
"""
RecordTime = 1 minute
"""
How long to record after startup sequence (hopefully) turns on Optim camera
"""
BackseatWait = 30 second
"""
How long to wait for the backseat to power up before attempting to power the Optim
"""
LightMode = 2 count
"""
Mode for Multiray lights. 0 is off, 1 is red, 2 is white
"""
BrightnessWhite = 100 none_int
"""
White Multiray LED brightness, 0-100
"""
BrightnessRed = 100 none_int
"""
Red Multiray LED brightness, 0-100
"""
}
output {
RecordingEnabled = false
LightsEnabled = false
}
timeout duration=MissionTimeout
insert Insert/BackseatDriver.tl
assign in parallel BackseatDriver:EnableBackseat = true
readData strategy="MinError" {
while ( RecordingEnabled )
Sensor:PowerOnly.sampleLoad1
}
readData strategy="MinError" {
while ( LightsEnabled )
Sensor:MultiRay.lightModeLog
}
aggregate Startup {
run in sequence
syslog important "Waiting " + BackseatWait~s + " for backseat to start up..."
behavior Guidance:Wait {
run in sequence
set duration = BackseatWait
}
}
aggregate Run {
run in sequence
syslog important "Trying to run Optim and Multiray forreal"
assign in sequence RecordingEnabled = true
assign in sequence LightsEnabled = true
assign in sequence Sensor:MultiRay.lightModeCommand = LightMode
aggregate setRed {
run in sequence
break if ( LightMode != 1 count )
assign in sequence Sensor:MultiRay.brightnessRed = BrightnessRed
syslog info "Setting multiray red brightness to" + BrightnessRed~count
}
aggregate setWhite {
run in sequence
break if ( LightMode != 2 count )
assign in sequence Sensor:MultiRay.brightnessWhite = BrightnessWhite
syslog info "Setting muliray white brightness to" + BrightnessWhite~count
}
syslog important "Recording for " + RecordTime~min
behavior Guidance:Wait {
run in sequence
set duration = RecordTime
}
}
behavior Guidance:Wait {
run in sequence
set duration = MissionTimeout
}
}
2025-03-11T16:34:29.665Z,1741710869.665 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/lab_test_optim.tl id=lab_test_optim
2025-03-11T16:34:29.805Z,1741710869.805 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2025-03-11T16:34:29.805Z,1741710869.805 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:34:29.822Z,1741710869.822 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:34:30.203Z,1741710870.203 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:34:30.203Z,1741710870.203 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2025-03-11T16:34:32.798Z,1741710872.798 [CommandExec](IMPORTANT): got command set lab_test_optim.RecordTime 10 minute
2025-03-11T16:34:32.798Z,1741710872.798 [CommandExec](IMPORTANT): got command run
2025-03-11T16:34:32.800Z,1741710872.800 [CommandExec](IMPORTANT): Running
2025-03-11T16:34:33.010Z,1741710873.010 [Default] Stopped
2025-03-11T16:34:33.010Z,1741710873.010 [Default](DEBUG): Aggregate::uninitialize Default
2025-03-11T16:34:33.010Z,1741710873.010 [Default:B.GoToSurface] Stopped
2025-03-11T16:34:33.010Z,1741710873.010 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-11T16:34:33.010Z,1741710873.010 [Default:CheckIn] Stopped
2025-03-11T16:34:33.011Z,1741710873.011 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-03-11T16:34:33.011Z,1741710873.011 [Default:CheckIn:Read_GPS] Stopped
2025-03-11T16:34:33.011Z,1741710873.011 [MissionManager](IMPORTANT): Started mission lab_test_optim
2025-03-11T16:34:33.011Z,1741710873.011 [lab_test_optim] Running Loop=1
2025-03-11T16:34:33.011Z,1741710873.011 [lab_test_optim](DEBUG): Aggregate::initialize lab_test_optim
2025-03-11T16:34:33.011Z,1741710873.011 [lab_test_optim:BackseatDriver] Running Loop=1
2025-03-11T16:34:33.011Z,1741710873.011 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::initialize lab_test_optim:BackseatDriver
2025-03-11T16:34:33.011Z,1741710873.011 [lab_test_optim:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-03-11T16:34:33.011Z,1741710873.011 [lab_test_optim:B] Running Loop=1
2025-03-11T16:34:33.012Z,1741710873.012 [lab_test_optim:C] Running Loop=1
2025-03-11T16:34:33.012Z,1741710873.012 [lab_test_optim:D] Running Loop=1
2025-03-11T16:34:33.012Z,1741710873.012 [lab_test_optim:Startup] Running Loop=1
2025-03-11T16:34:33.012Z,1741710873.012 [lab_test_optim:Startup](DEBUG): Aggregate::initialize lab_test_optim:Startup
2025-03-11T16:34:33.012Z,1741710873.012 [lab_test_optim:Startup:A] Running Loop=1
2025-03-11T16:34:33.013Z,1741710873.013 [lab_test_optim:Startup:A](IMPORTANT): Waiting 30.000000 s for backseat to start up...
2025-03-11T16:34:33.013Z,1741710873.013 [lab_test_optim:Startup:A] Stopped
2025-03-11T16:34:33.013Z,1741710873.013 [lab_test_optim:Startup:B.Wait] Running Loop=1
2025-03-11T16:34:33.013Z,1741710873.013 [lab_test_optim:Startup:B.Wait](DEBUG): Initialize Wait Component.
2025-03-11T16:34:33.013Z,1741710873.013 [lab_test_optim:D] Stopped
2025-03-11T16:34:33.013Z,1741710873.013 [lab_test_optim:C] Stopped
2025-03-11T16:34:33.013Z,1741710873.013 [lab_test_optim:B] Running Loop=1
2025-03-11T16:34:33.014Z,1741710873.014 [lab_test_optim:BackseatDriver] Running Loop=1
2025-03-11T16:34:33.014Z,1741710873.014 [lab_test_optim:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-03-11T16:34:33.022Z,1741710873.022 [BackseatComponent](INFO): Powering up
2025-03-11T16:34:33.022Z,1741710873.022 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-03-11T16:34:41.933Z,1741710881.933 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:35:03.711Z,1741710903.711 [lab_test_optim:Startup:B.Wait](INFO): Done Waiting.
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Startup:B.Wait] Stopped
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Startup:B.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Startup](INFO): Completed lab_test_optim:Startup
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Startup] Stopped
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Startup](DEBUG): Aggregate::uninitialize lab_test_optim:Startup
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Run] Running Loop=1
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Run](DEBUG): Aggregate::initialize lab_test_optim:Run
2025-03-11T16:35:03.712Z,1741710903.712 [lab_test_optim:Run:A] Running Loop=1
2025-03-11T16:35:04.116Z,1741710904.116 [lab_test_optim:Run:A](IMPORTANT): Trying to run Optim and Multiray forreal
2025-03-11T16:35:04.116Z,1741710904.116 [lab_test_optim:Run:A] Stopped
2025-03-11T16:35:04.116Z,1741710904.116 [lab_test_optim:Run:B] Running Loop=1
2025-03-11T16:35:04.532Z,1741710904.532 [lab_test_optim:Run:B] Stopped
2025-03-11T16:35:04.532Z,1741710904.532 [lab_test_optim:Run:C] Running Loop=1
2025-03-11T16:35:04.940Z,1741710904.940 [lab_test_optim:Run:C] Stopped
2025-03-11T16:35:04.940Z,1741710904.940 [lab_test_optim:Run:D] Running Loop=1
2025-03-11T16:35:04.940Z,1741710904.940 [lab_test_optim:C] Running Loop=1
2025-03-11T16:35:04.940Z,1741710904.940 [lab_test_optim:C] Running Loop=1
2025-03-11T16:35:04.941Z,1741710904.941 [lab_test_optim:C](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1
2025-03-11T16:35:05.326Z,1741710905.326 [PowerOnly](INFO): Powering up loadControl
2025-03-11T16:35:05.371Z,1741710905.371 [lab_test_optim:Run:D] Stopped
2025-03-11T16:35:05.371Z,1741710905.371 [lab_test_optim:Run:setRed] Running Loop=1
2025-03-11T16:35:05.372Z,1741710905.372 [lab_test_optim:Run:setRed](DEBUG): Aggregate::initialize lab_test_optim:Run:setRed
2025-03-11T16:35:05.373Z,1741710905.373 [lab_test_optim:Run:setRed:A] Running Loop=1
2025-03-11T16:35:05.373Z,1741710905.373 [lab_test_optim:D] Running Loop=1
2025-03-11T16:35:05.373Z,1741710905.373 [lab_test_optim:D] Running Loop=1
2025-03-11T16:35:05.374Z,1741710905.374 [lab_test_optim:D](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2025-03-11T16:35:05.727Z,1741710905.727 [lab_test_optim:Run:setRed] Stopped
2025-03-11T16:35:05.728Z,1741710905.728 [lab_test_optim:Run:setRed](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setRed
2025-03-11T16:35:05.728Z,1741710905.728 [lab_test_optim:Run:setRed:A] Stopped
2025-03-11T16:35:05.728Z,1741710905.728 [lab_test_optim:Run:setWhite] Running Loop=1
2025-03-11T16:35:05.728Z,1741710905.728 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::initialize lab_test_optim:Run:setWhite
2025-03-11T16:35:05.728Z,1741710905.728 [lab_test_optim:Run:setWhite:A] Running Loop=1
2025-03-11T16:35:06.216Z,1741710906.216 [lab_test_optim:Run:setWhite:A] Stopped
2025-03-11T16:35:06.216Z,1741710906.216 [lab_test_optim:Run:setWhite:B] Running Loop=1
2025-03-11T16:35:06.584Z,1741710906.584 [lab_test_optim:Run:setWhite:B](INFO): Setting muliray white brightness to 100.000000 count
2025-03-11T16:35:06.584Z,1741710906.584 [lab_test_optim:Run:setWhite:B] Stopped
2025-03-11T16:35:06.584Z,1741710906.584 [lab_test_optim:Run:setWhite](INFO): Completed lab_test_optim:Run:setWhite
2025-03-11T16:35:06.584Z,1741710906.584 [lab_test_optim:Run:setWhite] Stopped
2025-03-11T16:35:06.584Z,1741710906.584 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setWhite
2025-03-11T16:35:06.585Z,1741710906.585 [lab_test_optim:Run:G] Running Loop=1
2025-03-11T16:35:06.952Z,1741710906.952 [lab_test_optim:Run:G](IMPORTANT): Recording for 10.000000 min
2025-03-11T16:35:06.952Z,1741710906.952 [lab_test_optim:Run:G] Stopped
2025-03-11T16:35:06.952Z,1741710906.952 [lab_test_optim:Run:H.Wait] Running Loop=1
2025-03-11T16:35:06.952Z,1741710906.952 [lab_test_optim:Run:H.Wait](DEBUG): Initialize Wait Component.
2025-03-11T16:35:08.543Z,1741710908.543 [MultiRay](IMPORTANT): MultiRay white lights ON
2025-03-11T16:35:22.738Z,1741710922.738 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:35:30.905Z,1741710930.905 [BackseatComponent](IMPORTANT): ikshana: running backseat application.
2025-03-11T16:35:33.611Z,1741710933.611 [BackseatComponent](INFO): Created universal data reader for depth with code: 6
2025-03-11T16:35:33.612Z,1741710933.612 [BackseatComponent](INFO): Requesting data from depth (6). Requested size is: 1
2025-03-11T16:36:29.799Z,1741710989.799 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:37:23.575Z,1741711043.575 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:37:30.760Z,1741711050.760 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2025-03-11T16:37:30.760Z,1741711050.760 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:37:30.790Z,1741711050.790 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:37:31.173Z,1741711051.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:37:31.173Z,1741711051.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2025-03-11T16:38:25.338Z,1741711105.338 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:38:33.472Z,1741711113.472 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:39:09.412Z,1741711149.412 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:39:10.163Z,1741711150.163 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-03-11T16:39:10.163Z,1741711150.163 [NAL9602] Data Fault, FailCount= 1
2025-03-11T16:39:10.163Z,1741711150.163 [NAL9602](ERROR): Data Fault
2025-03-11T16:39:10.256Z,1741711150.256 [CBIT](ERROR): Data Fault in component: NAL9602
2025-03-11T16:39:10.551Z,1741711150.551 [NAL9602](INFO): Powering down
2025-03-11T16:39:11.385Z,1741711151.385 [CBIT](INFO): Clearing failed state for component NAL9602
2025-03-11T16:39:11.386Z,1741711151.386 [NAL9602] No Fault, FailCount= 1
2025-03-11T16:39:40.839Z,1741711180.839 [NAL9602](INFO): Powering up NAL9602
2025-03-11T16:39:51.747Z,1741711191.747 [NAL9602](INFO): NAL9602 initialized
2025-03-11T16:40:10.374Z,1741711210.374 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:40:31.794Z,1741711231.794 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2025-03-11T16:40:31.794Z,1741711231.794 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:40:31.805Z,1741711231.805 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:40:32.181Z,1741711232.181 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:40:32.181Z,1741711232.181 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2025-03-11T16:41:10.579Z,1741711270.579 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:41:24.316Z,1741711284.316 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:42:31.383Z,1741711351.383 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:42:58.045Z,1741711378.045 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:43:32.742Z,1741711412.742 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2025-03-11T16:43:32.742Z,1741711412.742 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:43:32.753Z,1741711412.753 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:43:33.165Z,1741711413.165 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:43:33.165Z,1741711413.165 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2025-03-11T16:43:51.784Z,1741711431.784 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:44:07.130Z,1741711447.130 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:44:33.793Z,1741711473.793 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:44:47.125Z,1741711487.125 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:45:07.712Z,1741711507.712 [lab_test_optim:Run:H.Wait](INFO): Done Waiting.
2025-03-11T16:45:07.712Z,1741711507.712 [lab_test_optim:Run:H.Wait] Stopped
2025-03-11T16:45:07.712Z,1741711507.712 [lab_test_optim:Run:H.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T16:45:07.712Z,1741711507.712 [lab_test_optim:Run](INFO): Completed lab_test_optim:Run
2025-03-11T16:45:07.712Z,1741711507.712 [lab_test_optim:Run] Stopped
2025-03-11T16:45:07.713Z,1741711507.713 [lab_test_optim:Run](DEBUG): Aggregate::uninitialize lab_test_optim:Run
2025-03-11T16:45:07.713Z,1741711507.713 [lab_test_optim:G.Wait] Running Loop=1
2025-03-11T16:45:07.713Z,1741711507.713 [lab_test_optim:G.Wait](DEBUG): Initialize Wait Component.
2025-03-11T16:45:31.531Z,1741711531.531 [lab_test_optim:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.data_dir_logging_rate with code: 1973
2025-03-11T16:45:39.280Z,1741711539.280 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:45:52.169Z,1741711552.169 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:46:33.754Z,1741711593.754 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2025-03-11T16:46:33.754Z,1741711593.754 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:46:33.765Z,1741711593.765 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:46:34.173Z,1741711594.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:46:34.173Z,1741711594.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2025-03-11T16:46:45.903Z,1741711605.903 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:47:12.163Z,1741711632.163 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:47:30.078Z,1741711650.078 [DataOverHttps](IMPORTANT): SBD MTMSN=20250311T164729
2025-03-11T16:47:37.547Z,1741711657.547 [DataOverHttps](INFO): Received command: stop
2025-03-11T16:47:37.558Z,1741711657.558 [CommandExec](IMPORTANT): got command stop
2025-03-11T16:47:37.558Z,1741711657.558 [CommandExec](IMPORTANT): Scheduling is paused
2025-03-11T16:47:37.558Z,1741711657.558 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2025-03-11T16:47:37.581Z,1741711657.581 [MissionManager](INFO): MissionManager is completed.
2025-03-11T16:47:37.581Z,1741711657.581 [MissionManager](INFO): Uninitializing Mission lab_test_optim
2025-03-11T16:47:37.581Z,1741711657.581 [lab_test_optim] Stopped
2025-03-11T16:47:37.581Z,1741711657.581 [lab_test_optim](DEBUG): Aggregate::uninitialize lab_test_optim
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:BackseatDriver] Stopped
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::uninitialize lab_test_optim:BackseatDriver
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:BackseatDriver:A.BackseatDriver] Stopped
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:B] Stopped
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:C] Stopped
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:D] Stopped
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:G.Wait] Stopped
2025-03-11T16:47:37.582Z,1741711657.582 [lab_test_optim:G.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T16:47:37.777Z,1741711657.777 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-03-11T16:47:37.777Z,1741711657.777 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-03-11T16:47:38.010Z,1741711658.010 [MissionManager](IMPORTANT): Started mission Default
2025-03-11T16:47:38.011Z,1741711658.011 [Default] Running Loop=1
2025-03-11T16:47:38.011Z,1741711658.011 [Default](DEBUG): Aggregate::initialize Default
2025-03-11T16:47:38.011Z,1741711658.011 [Default:B.GoToSurface] Running Loop=1
2025-03-11T16:47:38.011Z,1741711658.011 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-11T16:47:38.011Z,1741711658.011 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-11T16:47:38.012Z,1741711658.012 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-11T16:47:38.012Z,1741711658.012 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-11T16:47:38.012Z,1741711658.012 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-11T16:47:38.012Z,1741711658.012 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-11T16:47:38.013Z,1741711658.013 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-11T16:47:38.014Z,1741711658.014 [Default:A.Wait] Running Loop=1
2025-03-11T16:47:38.014Z,1741711658.014 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-03-11T16:47:51.304Z,1741711671.304 [Default:A.Wait](INFO): Done Waiting.
2025-03-11T16:47:51.304Z,1741711671.304 [Default:A.Wait] Stopped
2025-03-11T16:47:51.304Z,1741711671.304 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T16:47:51.708Z,1741711671.708 [Default:CheckIn] Running Loop=1
2025-03-11T16:47:51.708Z,1741711671.708 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-03-11T16:47:51.708Z,1741711671.708 [Default:CheckIn:Read_GPS] Running Loop=1
2025-03-11T16:47:55.962Z,1741711675.962 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-03-11T16:47:55.963Z,1741711675.963 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-03-11T16:47:55.963Z,1741711675.963 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-03-11T16:48:06.640Z,1741711686.640 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-03-11T16:48:49.523Z,1741711729.523 [DataOverHttps](IMPORTANT): SBD MTMSN=20250311T164848
2025-03-11T16:48:56.854Z,1741711736.854 [DataOverHttps](INFO): Received command: run Maintenance/run_backseat_on_surface.tl
2025-03-11T16:48:56.957Z,1741711736.957 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T16:48:56.958Z,1741711736.958 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T16:48:56.958Z,1741711736.958 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T16:48:56.959Z,1741711736.959 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T16:48:59.813Z,1741711739.813 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into:
0
Burn on
Dropped weight due to communications timeout.
5
run_backseat_on_surface mission has been running for
Restarting logs and run_backseat_on_surface mission.
restart logs
2025-03-11T16:48:59.819Z,1741711739.819 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min
2025-03-11T16:48:59.819Z,1741711739.819 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl
2025-03-11T16:48:59.819Z,1741711739.819 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl
2025-03-11T16:48:59.823Z,1741711739.823 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl
2025-03-11T16:49:02.246Z,1741711742.246 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into:
NaN
3
100
80
20
5
NaN
NaN
2.0
NaN
0
NaN
NaN
5
0
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
PeakDetectVsDepth
EdgeDetectVsDepth
GoDown, ChlPeakThresh, PeakChl, PeakChlDepth, EdgeChl, EdgeChlDepth =
,
,
,
,
,
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
_.planktivore_LM_AvgRois
EdgeDetectVsDepth
_.planktivore_LM_AvgRois
GoDown, PlanktivoreLMavgROIPeakThresh, PeakPlanktivoreLMavgROI, PeakPlanktivoreLMavgROIDepth, EdgePlanktivoreLMavgROI, EdgePlanktivoreLMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_HM_AvgRois
PeakDetectVsDepth
_.planktivore_diatoms
PeakDetectVsDepth
_.planktivore_dinoflagellates
Triggered. PeakChl values on
consecutive yo-yo profiles fall in [
] (NaN bound is ignored).
2025-03-11T16:49:02.267Z,1741711742.267 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool
2025-03-11T16:49:02.269Z,1741711742.269 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectChlActive = 0 bool
2025-03-11T16:49:02.272Z,1741711742.272 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min
2025-03-11T16:49:02.275Z,1741711742.275 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool
2025-03-11T16:49:02.278Z,1741711742.278 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool
2025-03-11T16:49:02.280Z,1741711742.280 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool
2025-03-11T16:49:02.303Z,1741711742.303 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool
2025-03-11T16:49:02.307Z,1741711742.307 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count
2025-03-11T16:49:02.318Z,1741711742.318 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count
2025-03-11T16:49:02.326Z,1741711742.326 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 %
2025-03-11T16:49:02.328Z,1741711742.328 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool
2025-03-11T16:49:02.335Z,1741711742.335 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool
2025-03-11T16:49:02.339Z,1741711742.339 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool
2025-03-11T16:49:02.350Z,1741711742.350 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool
2025-03-11T16:49:02.353Z,1741711742.353 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool
2025-03-11T16:49:02.355Z,1741711742.355 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectPlanktivoreLMavgROIActive = 0 bool
2025-03-11T16:49:02.358Z,1741711742.358 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool
2025-03-11T16:49:02.360Z,1741711742.360 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool
2025-03-11T16:49:02.423Z,1741711742.423 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-03-11T16:49:02.426Z,1741711742.426 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2025-03-11T16:49:02.442Z,1741711742.442 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool
2025-03-11T16:49:02.445Z,1741711742.445 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool
2025-03-11T16:49:02.448Z,1741711742.448 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 1 bool
2025-03-11T16:49:02.469Z,1741711742.469 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 1 bool
2025-03-11T16:49:02.473Z,1741711742.473 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2025-03-11T16:49:02.492Z,1741711742.492 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool
2025-03-11T16:49:02.511Z,1741711742.511 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count
2025-03-11T16:49:02.523Z,1741711742.523 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count
2025-03-11T16:49:02.530Z,1741711742.530 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ShallowBound = nan m
2025-03-11T16:49:02.546Z,1741711742.546 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DeepBound = nan m
2025-03-11T16:49:02.549Z,1741711742.549 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2025-03-11T16:49:02.560Z,1741711742.560 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionVertical = nan %
2025-03-11T16:49:02.575Z,1741711742.575 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlPeakThresh = 0.000000 ug/l
2025-03-11T16:49:02.582Z,1741711742.582 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlThreshTriggerActive = 0 bool
2025-03-11T16:49:02.589Z,1741711742.589 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlLowerThresh = nan ug/l
2025-03-11T16:49:02.592Z,1741711742.592 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlUpperThresh = nan ug/l
2025-03-11T16:49:02.599Z,1741711742.599 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesThresh = 5.000000 count
2025-03-11T16:49:02.614Z,1741711742.614 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PlanktivoreLMavgROIPeakThresh = 0.000000 count/s
2025-03-11T16:49:02.617Z,1741711742.617 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.GoDown = 1 bool
2025-03-11T16:49:02.624Z,1741711742.624 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = nan ug/l
2025-03-11T16:49:02.631Z,1741711742.631 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = nan m
2025-03-11T16:49:02.635Z,1741711742.635 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = nan degC
2025-03-11T16:49:02.643Z,1741711742.643 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg
2025-03-11T16:49:02.651Z,1741711742.651 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg
2025-03-11T16:49:02.658Z,1741711742.658 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChl = nan ug/l
2025-03-11T16:49:02.665Z,1741711742.665 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlDepth = nan m
2025-03-11T16:49:02.669Z,1741711742.668 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlTemperature = nan degC
2025-03-11T16:49:02.676Z,1741711742.676 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlLatitude = nan arcdeg
2025-03-11T16:49:02.680Z,1741711742.680 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlLongitude = nan arcdeg
2025-03-11T16:49:02.695Z,1741711742.695 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = nan umol/l
2025-03-11T16:49:02.699Z,1741711742.699 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = nan m
2025-03-11T16:49:02.710Z,1741711742.710 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg
2025-03-11T16:49:02.717Z,1741711742.717 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg
2025-03-11T16:49:02.720Z,1741711742.720 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = nan kg/m3
2025-03-11T16:49:02.725Z,1741711742.725 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = nan m
2025-03-11T16:49:02.736Z,1741711742.736 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg
2025-03-11T16:49:02.748Z,1741711742.748 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg
2025-03-11T16:49:02.751Z,1741711742.751 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = nan ppb
2025-03-11T16:49:02.758Z,1741711742.758 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = nan m
2025-03-11T16:49:02.766Z,1741711742.766 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC
2025-03-11T16:49:02.769Z,1741711742.769 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg
2025-03-11T16:49:02.776Z,1741711742.776 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg
2025-03-11T16:49:02.779Z,1741711742.779 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = nan psu
2025-03-11T16:49:02.810Z,1741711742.810 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = nan m
2025-03-11T16:49:02.835Z,1741711742.835 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = nan degC
2025-03-11T16:49:02.839Z,1741711742.839 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg
2025-03-11T16:49:02.862Z,1741711742.862 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg
2025-03-11T16:49:02.869Z,1741711742.869 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROI = nan count/s
2025-03-11T16:49:02.877Z,1741711742.877 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROIDepth = nan m
2025-03-11T16:49:02.884Z,1741711742.884 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROITemperature = nan degC
2025-03-11T16:49:02.896Z,1741711742.896 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg
2025-03-11T16:49:02.908Z,1741711742.908 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg
2025-03-11T16:49:02.911Z,1741711742.911 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROI = nan count/s
2025-03-11T16:49:02.927Z,1741711742.927 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROIDepth = nan m
2025-03-11T16:49:02.939Z,1741711742.939 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROITemperature = nan degC
2025-03-11T16:49:02.946Z,1741711742.946 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROILatitude = nan arcdeg
2025-03-11T16:49:02.954Z,1741711742.954 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROILongitude = nan arcdeg
2025-03-11T16:49:02.957Z,1741711742.957 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROI = nan count/s
2025-03-11T16:49:02.964Z,1741711742.964 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROIDepth = nan m
2025-03-11T16:49:02.971Z,1741711742.971 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROITemperature = nan degC
2025-03-11T16:49:02.976Z,1741711742.976 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg
2025-03-11T16:49:02.991Z,1741711742.991 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg
2025-03-11T16:49:02.994Z,1741711742.994 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatoms = nan count/ml
2025-03-11T16:49:03.002Z,1741711743.002 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsDepth = nan m
2025-03-11T16:49:03.013Z,1741711743.013 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsTemperature = nan degC
2025-03-11T16:49:03.016Z,1741711743.016 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg
2025-03-11T16:49:03.024Z,1741711743.024 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg
2025-03-11T16:49:03.028Z,1741711743.028 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellates = nan count/ml
2025-03-11T16:49:03.039Z,1741711743.039 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesDepth = nan m
2025-03-11T16:49:03.046Z,1741711743.046 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC
2025-03-11T16:49:03.052Z,1741711743.052 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-03-11T16:49:03.055Z,1741711743.055 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-03-11T16:49:03.059Z,1741711743.059 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = nan ug/l
2025-03-11T16:49:03.074Z,1741711743.074 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = nan m
2025-03-11T16:49:03.082Z,1741711743.082 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg
2025-03-11T16:49:03.085Z,1741711743.085 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg
2025-03-11T16:49:03.092Z,1741711743.092 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m
2025-03-11T16:49:03.106Z,1741711743.106 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = nan psu
2025-03-11T16:49:03.113Z,1741711743.113 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = nan m
2025-03-11T16:49:03.116Z,1741711743.116 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg
2025-03-11T16:49:03.124Z,1741711743.124 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg
2025-03-11T16:49:03.128Z,1741711743.128 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m
2025-03-11T16:49:03.143Z,1741711743.143 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = nan psu
2025-03-11T16:49:03.150Z,1741711743.150 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = nan m
2025-03-11T16:49:03.162Z,1741711743.162 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg
2025-03-11T16:49:03.165Z,1741711743.165 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg
2025-03-11T16:49:03.172Z,1741711743.172 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m
2025-03-11T16:49:03.187Z,1741711743.187 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.TriggeredOnChl = 0 bool
2025-03-11T16:49:03.207Z,1741711743.207 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.ChlTriggering = nan ug/l
2025-03-11T16:49:03.314Z,1741711743.314 [run_backseat_on_surface:Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.354Z,1741711743.354 [run_backseat_on_surface:Science:EdgeDetectChl:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-03-11T16:49:03.403Z,1741711743.403 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-03-11T16:49:03.435Z,1741711743.435 [run_backseat_on_surface:Science:PeakDetectNO3:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.465Z,1741711743.465 [run_backseat_on_surface:Science:PeakDetectOil:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.492Z,1741711743.492 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-03-11T16:49:03.535Z,1741711743.535 [run_backseat_on_surface:Science:PeakDetectFDOM:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.564Z,1741711743.564 [run_backseat_on_surface:Science:PeakDetectSalinity:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.615Z,1741711743.615 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-03-11T16:49:03.669Z,1741711743.669 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.715Z,1741711743.715 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-03-11T16:49:03.771Z,1741711743.771 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.800Z,1741711743.800 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.830Z,1741711743.830 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T16:49:03.860Z,1741711743.860 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2025-03-11T16:49:03.872Z,1741711743.872 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-03-11T16:49:03.872Z,1741711743.872 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-03-11T16:49:03.881Z,1741711743.881 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-03-11T16:49:03.928Z,1741711743.928 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-03-11T16:49:03.936Z,1741711743.936 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool
2025-03-11T16:49:03.942Z,1741711743.942 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-03-11T16:49:03.951Z,1741711743.951 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-03-11T16:49:03.951Z,1741711743.951 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-03-11T16:49:03.953Z,1741711743.953 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-03-11T16:49:04.228Z,1741711744.228 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-03-11T16:49:04.237Z,1741711744.237 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool
2025-03-11T16:49:04.244Z,1741711744.244 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool
2025-03-11T16:49:04.247Z,1741711744.247 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool
2025-03-11T16:49:04.262Z,1741711744.262 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool
2025-03-11T16:49:04.266Z,1741711744.266 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 1 bool
2025-03-11T16:49:04.286Z,1741711744.286 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-03-11T16:49:04.288Z,1741711744.288 [run_backseat_on_surface:E.GoToSurface](DEBUG): Construct GoToSurface.
2025-03-11T16:49:04.316Z,1741711744.316 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-03-11T16:49:04.331Z,1741711744.331 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-03-11T16:49:04.342Z,1741711744.342 [run_backseat_on_surface:H.Execute](DEBUG): Construct Execute.
2025-03-11T16:49:04.457Z,1741711744.457 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission run_backseat_on_surface {
arguments {
ElapsedSinceMissionStarted = 0 minute
}
# Power the science payload.
insert id="Science" Insert/Science.tl
# Power the Backseat payload.
insert Insert/BackseatDriver.tl
assign in sequence BackseatDriver:EnableBackseat = true
insert Insert/PowerOnly.tl
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P2H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceMissionStarted = elapsed ( Universal:mission_started )
syslog important "run_backseat_on_surface mission has been running for "
+ ElapsedSinceMissionStarted~minute
}
syslog important "Restarting logs and run_backseat_on_surface mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2025-03-11T16:49:04.469Z,1741711744.469 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T16:49:04.513Z,1741711744.513 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:49:04.529Z,1741711744.529 [Default] Stopped
2025-03-11T16:49:04.529Z,1741711744.529 [Default](DEBUG): Aggregate::uninitialize Default
2025-03-11T16:49:04.529Z,1741711744.529 [Default:B.GoToSurface] Stopped
2025-03-11T16:49:04.530Z,1741711744.530 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-11T16:49:04.530Z,1741711744.530 [Default:CheckIn] Stopped
2025-03-11T16:49:04.530Z,1741711744.530 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-03-11T16:49:04.530Z,1741711744.530 [Default:CheckIn:Read_GPS] Stopped
2025-03-11T16:49:04.530Z,1741711744.530 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface
2025-03-11T16:49:04.530Z,1741711744.530 [run_backseat_on_surface] Running Loop=1
2025-03-11T16:49:04.530Z,1741711744.530 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface
2025-03-11T16:49:04.530Z,1741711744.530 [run_backseat_on_surface:Science] Running Loop=1
2025-03-11T16:49:04.530Z,1741711744.530 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:A] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:B] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:C] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:D] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:E] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:F] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:PeakDetectChl:A] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:EdgeDetectChl] Running Loop=1
2025-03-11T16:49:04.531Z,1741711744.531 [run_backseat_on_surface:Science:EdgeDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectChl
2025-03-11T16:49:04.532Z,1741711744.532 [run_backseat_on_surface:Science:EdgeDetectChl:A] Running Loop=1
2025-03-11T16:49:04.532Z,1741711744.532 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1
2025-03-11T16:49:04.532Z,1741711744.532 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport
2025-03-11T16:49:04.532Z,1741711744.532 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-03-11T16:49:04.532Z,1741711744.532 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-03-11T16:49:04.533Z,1741711744.533 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1
2025-03-11T16:49:04.533Z,1741711744.533 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:PeakDetectNO3:A] Running Loop=1
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:PeakDetectOil:A] Running Loop=1
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-03-11T16:49:04.538Z,1741711744.538 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:PeakDetectFDOM:A] Running Loop=1
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:PeakDetectSalinity:A] Running Loop=1
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1
2025-03-11T16:49:04.539Z,1741711744.539 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport
2025-03-11T16:49:04.540Z,1741711744.540 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-03-11T16:49:04.540Z,1741711744.540 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-03-11T16:49:04.540Z,1741711744.540 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-03-11T16:49:04.540Z,1741711744.540 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI
2025-03-11T16:49:04.540Z,1741711744.540 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-03-11T16:49:04.540Z,1741711744.540 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI] Running Loop=1
2025-03-11T16:49:04.540Z,1741711744.540 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI
2025-03-11T16:49:04.549Z,1741711744.549 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-03-11T16:49:04.549Z,1741711744.549 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-03-11T16:49:04.557Z,1741711744.557 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI
2025-03-11T16:49:04.557Z,1741711744.557 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-03-11T16:49:04.557Z,1741711744.557 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-03-11T16:49:04.558Z,1741711744.558 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms
2025-03-11T16:49:04.558Z,1741711744.558 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:A] Running Loop=1
2025-03-11T16:49:04.558Z,1741711744.558 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-03-11T16:49:04.558Z,1741711744.558 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates
2025-03-11T16:49:04.559Z,1741711744.559 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-03-11T16:49:04.559Z,1741711744.559 [run_backseat_on_surface:Science:ChlThreshTrigger] Running Loop=1
2025-03-11T16:49:04.560Z,1741711744.560 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:ChlThreshTrigger
2025-03-11T16:49:04.560Z,1741711744.560 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-03-11T16:49:04.560Z,1741711744.560 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-03-11T16:49:04.582Z,1741711744.582 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:PowerOnly:A] Running Loop=1
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:PowerOnly:B] Running Loop=1
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:PowerOnly:C] Running Loop=1
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:PowerOnly:D] Running Loop=1
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:E.GoToSurface] Running Loop=1
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-11T16:49:04.583Z,1741711744.583 [run_backseat_on_surface:E.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-11T16:49:04.584Z,1741711744.584 [run_backseat_on_surface:E.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-11T16:49:04.584Z,1741711744.584 [run_backseat_on_surface:E.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-11T16:49:04.584Z,1741711744.584 [run_backseat_on_surface:E.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-11T16:49:04.585Z,1741711744.585 [run_backseat_on_surface:E.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-11T16:49:04.585Z,1741711744.585 [run_backseat_on_surface:E.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-11T16:49:04.589Z,1741711744.589 [run_backseat_on_surface:C] Running Loop=1
2025-03-11T16:49:04.590Z,1741711744.590 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-03-11T16:49:04.591Z,1741711744.591 [run_backseat_on_surface:PowerOnly:D] Stopped
2025-03-11T16:49:04.591Z,1741711744.591 [run_backseat_on_surface:PowerOnly:C] Stopped
2025-03-11T16:49:04.591Z,1741711744.591 [run_backseat_on_surface:PowerOnly:B] Stopped
2025-03-11T16:49:04.591Z,1741711744.591 [run_backseat_on_surface:PowerOnly:A] Stopped
2025-03-11T16:49:04.591Z,1741711744.591 [run_backseat_on_surface:C] Stopped
2025-03-11T16:49:04.591Z,1741711744.591 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-03-11T16:49:04.592Z,1741711744.592 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-03-11T16:49:04.605Z,1741711744.605 [BackseatComponent](INFO): Powering up
2025-03-11T16:49:04.606Z,1741711744.606 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-03-11T16:49:04.641Z,1741711744.641 [run_backseat_on_surface:Science] Running Loop=1
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:ChlThreshTrigger] Stopped
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:ChlThreshTrigger
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:A] Stopped
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-03-11T16:49:04.643Z,1741711744.643 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:A] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:A] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:A] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:A] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport
2025-03-11T16:49:04.644Z,1741711744.644 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-03-11T16:49:04.645Z,1741711744.645 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-03-11T16:49:04.645Z,1741711744.645 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped
2025-03-11T16:49:04.645Z,1741711744.645 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity
2025-03-11T16:49:04.645Z,1741711744.645 [run_backseat_on_surface:Science:PeakDetectSalinity:A] Stopped
2025-03-11T16:49:04.645Z,1741711744.645 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped
2025-03-11T16:49:04.649Z,1741711744.649 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM
2025-03-11T16:49:04.649Z,1741711744.649 [run_backseat_on_surface:Science:PeakDetectFDOM:A] Stopped
2025-03-11T16:49:04.649Z,1741711744.649 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped
2025-03-11T16:49:04.649Z,1741711744.649 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:PeakDetectOil] Stopped
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:PeakDetectOil:A] Stopped
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:PeakDetectNO3:A] Stopped
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-03-11T16:49:04.650Z,1741711744.650 [run_backseat_on_surface:Science:EdgeDetectChl] Stopped
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:EdgeDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectChl
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:EdgeDetectChl:A] Stopped
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:PeakDetectChl] Stopped
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:PeakDetectChl:A] Stopped
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:Read_Oil] Stopped
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:F] Stopped
2025-03-11T16:49:04.651Z,1741711744.651 [run_backseat_on_surface:Science:E] Running Loop=1
2025-03-11T16:49:04.652Z,1741711744.652 [run_backseat_on_surface:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2025-03-11T16:49:04.652Z,1741711744.652 [run_backseat_on_surface:Science:D] Stopped
2025-03-11T16:49:04.652Z,1741711744.652 [run_backseat_on_surface:Science:C] Running Loop=1
2025-03-11T16:49:04.657Z,1741711744.657 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2025-03-11T16:49:04.658Z,1741711744.658 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2025-03-11T16:49:04.658Z,1741711744.658 [run_backseat_on_surface:Science:B] Running Loop=1
2025-03-11T16:49:04.659Z,1741711744.659 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2025-03-11T16:49:04.659Z,1741711744.659 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2025-03-11T16:49:04.659Z,1741711744.659 [run_backseat_on_surface:Science:A] Stopped
2025-03-11T16:49:04.869Z,1741711744.869 [run_backseat_on_surface:CheckIn] Running Loop=1
2025-03-11T16:49:04.870Z,1741711744.870 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2025-03-11T16:49:04.870Z,1741711744.870 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2025-03-11T16:49:05.043Z,1741711745.043 [WetLabsBB2FL](INFO): Powering up
2025-03-11T16:49:05.252Z,1741711745.252 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-03-11T16:49:06.872Z,1741711746.872 [CTD_Seabird](ERROR): Pressure reading out of range: -103.059998 decibar
2025-03-11T16:49:06.874Z,1741711746.874 [CTD_Seabird](INFO): some bad data, not updating bins
2025-03-11T16:49:08.074Z,1741711748.074 [PowerOnly](INFO): Powering down loadControl
2025-03-11T16:49:34.754Z,1741711774.754 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2025-03-11T16:49:34.754Z,1741711774.754 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:49:34.771Z,1741711774.771 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:49:35.160Z,1741711775.160 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:49:35.160Z,1741711775.160 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2025-03-11T16:49:42.040Z,1741711782.040 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:49:52.900Z,1741711792.900 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-03-11T16:49:52.900Z,1741711792.900 [NAL9602] Data Fault, FailCount= 2
2025-03-11T16:49:52.900Z,1741711792.900 [NAL9602](ERROR): Data Fault
2025-03-11T16:49:52.942Z,1741711792.942 [CBIT](ERROR): Data Fault in component: NAL9602
2025-03-11T16:49:53.315Z,1741711793.315 [NAL9602](INFO): Powering down
2025-03-11T16:49:54.151Z,1741711794.151 [CBIT](INFO): Clearing failed state for component NAL9602
2025-03-11T16:49:54.151Z,1741711794.151 [NAL9602] No Fault, FailCount= 2
2025-03-11T16:50:03.769Z,1741711803.769 [BackseatComponent](IMPORTANT): ikshana: running backseat application.
2025-03-11T16:50:23.619Z,1741711823.619 [NAL9602](INFO): Powering up NAL9602
2025-03-11T16:50:34.508Z,1741711834.508 [NAL9602](INFO): NAL9602 initialized
2025-03-11T16:51:42.111Z,1741711902.111 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:52:35.726Z,1741711955.726 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2025-03-11T16:52:35.726Z,1741711955.726 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:52:35.745Z,1741711955.745 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:52:36.199Z,1741711956.199 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:52:36.199Z,1741711956.199 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2025-03-11T16:52:48.687Z,1741711968.687 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:53:15.356Z,1741711995.356 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:54:05.057Z,1741712045.057 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2025-03-11T16:49:04.9Z
2025-03-11T16:54:05.057Z,1741712045.057 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2025-03-11T16:54:05.061Z,1741712045.061 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1
2025-03-11T16:54:05.447Z,1741712045.447 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-03-11T16:54:12.533Z,1741712052.533 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250311T162817/Courier0004.lzma
2025-03-11T16:54:13.535Z,1741712053.535 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Courier0004.lzma.bak
2025-03-11T16:54:13.535Z,1741712053.535 [DataOverHttps](INFO): SBD MOMSN=24177048
2025-03-11T16:54:22.849Z,1741712062.849 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:54:29.388Z,1741712069.388 [DataOverHttps](INFO): Sending 902 bytes from file Logs/20250311T162817/Express0005.lzma
2025-03-11T16:54:30.387Z,1741712070.387 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Express0005.lzma.bak
2025-03-11T16:54:30.387Z,1741712070.387 [DataOverHttps](INFO): SBD MOMSN=24177050
2025-03-11T16:54:31.688Z,1741712071.688 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped
2025-03-11T16:54:31.688Z,1741712071.688 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1
2025-03-11T16:54:31.688Z,1741712071.688 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-03-11T16:54:35.414Z,1741712075.414 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:54:40.623Z,1741712080.623 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:55:36.734Z,1741712136.734 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2025-03-11T16:55:36.734Z,1741712136.734 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:55:36.747Z,1741712136.747 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:55:37.161Z,1741712137.161 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:55:37.161Z,1741712137.161 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2025-03-11T16:56:10.307Z,1741712170.307 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:57:46.059Z,1741712266.059 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:57:52.075Z,1741712272.075 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:58:37.734Z,1741712317.734 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2025-03-11T16:58:37.734Z,1741712317.734 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T16:58:37.751Z,1741712317.751 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T16:58:38.151Z,1741712318.151 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T16:58:38.151Z,1741712318.151 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2025-03-11T16:58:40.987Z,1741712320.987 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2025-03-11T16:59:01.591Z,1741712341.591 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:59:13.309Z,1741712353.309 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2025-03-11T16:59:29.822Z,1741712369.822 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5.
2025-03-11T16:59:29.825Z,1741712369.825 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle.
2025-03-11T16:59:32.288Z,1741712372.288 [run_backseat_on_surface:CheckIn:C.Wait](INFO): Done Waiting.
2025-03-11T16:59:32.288Z,1741712372.288 [run_backseat_on_surface:CheckIn:C.Wait] Stopped
2025-03-11T16:59:32.288Z,1741712372.288 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T16:59:32.288Z,1741712372.288 [run_backseat_on_surface:CheckIn:D] Running Loop=1
2025-03-11T16:59:32.664Z,1741712372.664 [run_backseat_on_surface:CheckIn:D] Stopped
2025-03-11T16:59:32.664Z,1741712372.664 [run_backseat_on_surface:CheckIn:E] Running Loop=1
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn:E](IMPORTANT): run_backseat_on_surface mission has been running for 10.468889 min
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn:E] Stopped
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn](INFO): Completed run_backseat_on_surface:CheckIn
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn] Stopped
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn](INFO): Running loop #2
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn] Running Loop=2
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2025-03-11T16:59:33.076Z,1741712373.076 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2025-03-11T17:00:04.185Z,1741712404.185 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.data_dir_logging_rate with code: 1973
2025-03-11T17:00:35.679Z,1741712435.679 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-03-11T17:00:35.679Z,1741712435.679 [NAL9602] Data Fault, FailCount= 3
2025-03-11T17:00:35.679Z,1741712435.679 [NAL9602](ERROR): Data Fault
2025-03-11T17:00:35.699Z,1741712435.699 [CBIT](ERROR): Data Fault in component: NAL9602
2025-03-11T17:00:36.087Z,1741712436.087 [NAL9602](INFO): Powering down
2025-03-11T17:00:36.927Z,1741712436.927 [CBIT](INFO): Clearing failed state for component NAL9602
2025-03-11T17:00:36.928Z,1741712436.928 [NAL9602] No Fault, FailCount= 3
2025-03-11T17:01:06.379Z,1741712466.379 [NAL9602](INFO): Powering up NAL9602
2025-03-11T17:01:17.291Z,1741712477.291 [NAL9602](INFO): NAL9602 initialized
2025-03-11T17:01:38.711Z,1741712498.711 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2025-03-11T17:01:38.711Z,1741712498.711 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:01:38.743Z,1741712498.743 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:01:39.133Z,1741712499.133 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:01:39.133Z,1741712499.133 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2025-03-11T17:04:33.281Z,1741712673.281 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2025-03-11T16:59:33.1Z
2025-03-11T17:04:33.281Z,1741712673.281 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2025-03-11T17:04:33.300Z,1741712673.300 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1
2025-03-11T17:04:39.738Z,1741712679.738 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2025-03-11T17:04:39.738Z,1741712679.738 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:04:39.771Z,1741712679.771 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:04:40.155Z,1741712680.155 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:04:40.155Z,1741712680.155 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2025-03-11T17:04:41.057Z,1741712681.057 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250311T162817/Courier0010.lzma
2025-03-11T17:04:42.059Z,1741712682.059 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Courier0010.lzma.bak
2025-03-11T17:04:42.059Z,1741712682.059 [DataOverHttps](INFO): SBD MOMSN=24177374
2025-03-11T17:04:57.942Z,1741712697.942 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20250311T162817/Express0011.lzma
2025-03-11T17:04:58.943Z,1741712698.943 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Express0011.lzma.bak
2025-03-11T17:04:58.944Z,1741712698.944 [DataOverHttps](INFO): SBD MOMSN=24177376
2025-03-11T17:04:59.971Z,1741712699.971 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped
2025-03-11T17:04:59.971Z,1741712699.971 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1
2025-03-11T17:04:59.971Z,1741712699.971 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:07:40.742Z,1741712860.742 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2025-03-11T17:07:40.742Z,1741712860.742 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:07:40.774Z,1741712860.774 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:07:41.159Z,1741712861.159 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:07:41.159Z,1741712861.159 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2025-03-11T17:09:03.507Z,1741712943.507 [CommandExec](IMPORTANT): got command get BackseatComponent.missionCritical
2025-03-11T17:09:03.508Z,1741712943.508 [CommandExec](IMPORTANT): BackseatComponent.missionCritical 1 bool
2025-03-11T17:09:16.207Z,1741712956.207 [DataOverHttps](IMPORTANT): SBD MTMSN=20250311T170915
2025-03-11T17:09:23.650Z,1741712963.650 [DataOverHttps](INFO): Received command: run Maintenance/run_backseat_on_surface.tl
2025-03-11T17:09:23.726Z,1741712963.726 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T17:09:23.726Z,1741712963.726 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface
2025-03-11T17:09:23.726Z,1741712963.726 [run_backseat_on_surface] Stopped
2025-03-11T17:09:23.726Z,1741712963.726 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface
2025-03-11T17:09:23.726Z,1741712963.726 [run_backseat_on_surface:Science] Stopped
2025-03-11T17:09:23.726Z,1741712963.726 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:Science:B] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:Science:C] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:Science:E] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:Science:OceanCurrent] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:BackseatDriver] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:PowerOnly] Stopped
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly
2025-03-11T17:09:23.727Z,1741712963.727 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped
2025-03-11T17:09:23.728Z,1741712963.728 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:09:23.728Z,1741712963.728 [run_backseat_on_surface:E.GoToSurface] Stopped
2025-03-11T17:09:23.728Z,1741712963.728 [run_backseat_on_surface:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-11T17:09:23.728Z,1741712963.728 [run_backseat_on_surface:CheckIn] Stopped
2025-03-11T17:09:23.728Z,1741712963.728 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2025-03-11T17:09:23.728Z,1741712963.728 [run_backseat_on_surface:CheckIn:C.Wait] Stopped
2025-03-11T17:09:23.728Z,1741712963.728 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:09:23.825Z,1741712963.825 [WetLabsBB2FL](INFO): Powering down
2025-03-11T17:09:23.880Z,1741712963.880 [MissionManager](INFO): Loading Mission from file: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T17:09:23.880Z,1741712963.880 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T17:09:23.894Z,1741712963.894 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T17:09:24.326Z,1741712964.326 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-03-11T17:09:24.327Z,1741712964.327 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-03-11T17:09:26.714Z,1741712966.714 [MissionManager](DEBUG): TethyslAPI: ./Missions/Maintenance/run_backseat_on_surface.tl translated into:
0
Burn on
Dropped weight due to communications timeout.
5
run_backseat_on_surface mission has been running for
Restarting logs and run_backseat_on_surface mission.
restart logs
2025-03-11T17:09:26.717Z,1741712966.717 [MissionManager](INFO): DefineArg run_backseat_on_surface.ElapsedSinceMissionStarted = 0.000000 min
2025-03-11T17:09:26.718Z,1741712966.718 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl
2025-03-11T17:09:26.718Z,1741712966.718 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl
2025-03-11T17:09:26.722Z,1741712966.722 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl
2025-03-11T17:09:29.154Z,1741712969.154 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into:
NaN
3
100
80
20
5
NaN
NaN
2.0
NaN
0
NaN
NaN
5
0
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
PeakDetectVsDepth
EdgeDetectVsDepth
GoDown, ChlPeakThresh, PeakChl, PeakChlDepth, EdgeChl, EdgeChlDepth =
,
,
,
,
,
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
_.planktivore_LM_AvgRois
EdgeDetectVsDepth
_.planktivore_LM_AvgRois
GoDown, PlanktivoreLMavgROIPeakThresh, PeakPlanktivoreLMavgROI, PeakPlanktivoreLMavgROIDepth, EdgePlanktivoreLMavgROI, EdgePlanktivoreLMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_HM_AvgRois
PeakDetectVsDepth
_.planktivore_diatoms
PeakDetectVsDepth
_.planktivore_dinoflagellates
Triggered. PeakChl values on
consecutive yo-yo profiles fall in [
] (NaN bound is ignored).
2025-03-11T17:09:29.175Z,1741712969.175 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectChlActive = 0 bool
2025-03-11T17:09:29.177Z,1741712969.177 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectChlActive = 0 bool
2025-03-11T17:09:29.179Z,1741712969.179 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.TimeWindowPeakReport = nan min
2025-03-11T17:09:29.181Z,1741712969.181 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestChlPeakReportActive = 0 bool
2025-03-11T17:09:29.183Z,1741712969.183 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestSaltPeakReportActive = 0 bool
2025-03-11T17:09:29.185Z,1741712969.185 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.HighestOilPeakReportActive = 0 bool
2025-03-11T17:09:29.222Z,1741712969.222 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PatchTracking = 0 bool
2025-03-11T17:09:29.224Z,1741712969.224 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.FilterWidthHorizontal = 3.000000 count
2025-03-11T17:09:29.234Z,1741712969.234 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesSlidingwindow = 100.000000 count
2025-03-11T17:09:29.237Z,1741712969.237 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionHorizontal = 80.000000 %
2025-03-11T17:09:29.247Z,1741712969.247 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectNO3Active = 0 bool
2025-03-11T17:09:29.249Z,1741712969.249 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectOilActive = 0 bool
2025-03-11T17:09:29.262Z,1741712969.262 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectFDOMActive = 0 bool
2025-03-11T17:09:29.264Z,1741712969.264 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectSalinityActive = 0 bool
2025-03-11T17:09:29.271Z,1741712969.271 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool
2025-03-11T17:09:29.272Z,1741712969.272 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EdgeDetectPlanktivoreLMavgROIActive = 0 bool
2025-03-11T17:09:29.279Z,1741712969.279 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool
2025-03-11T17:09:29.280Z,1741712969.280 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool
2025-03-11T17:09:29.287Z,1741712969.287 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-03-11T17:09:29.289Z,1741712969.289 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2025-03-11T17:09:29.295Z,1741712969.295 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledAanderaaO2 = 0 bool
2025-03-11T17:09:29.300Z,1741712969.300 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledNeilBrown = 0 bool
2025-03-11T17:09:29.311Z,1741712969.311 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledSeabird = 1 bool
2025-03-11T17:09:29.319Z,1741712969.319 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsBB2FL = 1 bool
2025-03-11T17:09:29.338Z,1741712969.338 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2025-03-11T17:09:29.340Z,1741712969.340 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.EnabledWetLabsUBAT = 0 bool
2025-03-11T17:09:29.351Z,1741712969.351 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.LowPassWindowLength = 20.000000 count
2025-03-11T17:09:29.361Z,1741712969.361 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.MedianFilterLen = 5.000000 count
2025-03-11T17:09:29.364Z,1741712969.364 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ShallowBound = nan m
2025-03-11T17:09:29.370Z,1741712969.370 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DeepBound = nan m
2025-03-11T17:09:29.373Z,1741712969.373 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2025-03-11T17:09:29.387Z,1741712969.387 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.OffPeakFractionVertical = nan %
2025-03-11T17:09:29.398Z,1741712969.398 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlPeakThresh = 0.000000 ug/l
2025-03-11T17:09:29.400Z,1741712969.400 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlThreshTriggerActive = 0 bool
2025-03-11T17:09:29.410Z,1741712969.410 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlLowerThresh = nan ug/l
2025-03-11T17:09:29.412Z,1741712969.412 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.ChlUpperThresh = nan ug/l
2025-03-11T17:09:29.442Z,1741712969.442 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.NumProfilesThresh = 5.000000 count
2025-03-11T17:09:29.444Z,1741712969.444 [MissionManager](INFO): DefineArg run_backseat_on_surface:Science.PlanktivoreLMavgROIPeakThresh = 0.000000 count/s
2025-03-11T17:09:29.463Z,1741712969.463 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.GoDown = 1 bool
2025-03-11T17:09:29.473Z,1741712969.473 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChl = nan ug/l
2025-03-11T17:09:29.482Z,1741712969.482 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlDepth = nan m
2025-03-11T17:09:29.484Z,1741712969.484 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlTemperature = nan degC
2025-03-11T17:09:29.495Z,1741712969.495 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLatitude = nan arcdeg
2025-03-11T17:09:29.497Z,1741712969.497 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakChlLongitude = nan arcdeg
2025-03-11T17:09:29.511Z,1741712969.511 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChl = nan ug/l
2025-03-11T17:09:29.526Z,1741712969.526 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlDepth = nan m
2025-03-11T17:09:29.528Z,1741712969.528 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlTemperature = nan degC
2025-03-11T17:09:29.534Z,1741712969.534 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlLatitude = nan arcdeg
2025-03-11T17:09:29.537Z,1741712969.537 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgeChlLongitude = nan arcdeg
2025-03-11T17:09:29.544Z,1741712969.544 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3 = nan umol/l
2025-03-11T17:09:29.555Z,1741712969.555 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Depth = nan m
2025-03-11T17:09:29.561Z,1741712969.561 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Latitude = nan arcdeg
2025-03-11T17:09:29.564Z,1741712969.564 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakNO3Longitude = nan arcdeg
2025-03-11T17:09:29.569Z,1741712969.569 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOil = nan kg/m3
2025-03-11T17:09:29.579Z,1741712969.579 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilDepth = nan m
2025-03-11T17:09:29.582Z,1741712969.582 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLatitude = nan arcdeg
2025-03-11T17:09:29.584Z,1741712969.584 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakOilLongitude = nan arcdeg
2025-03-11T17:09:29.595Z,1741712969.595 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOM = nan ppb
2025-03-11T17:09:29.598Z,1741712969.598 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMDepth = nan m
2025-03-11T17:09:29.600Z,1741712969.600 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMTemperature = nan degC
2025-03-11T17:09:29.602Z,1741712969.602 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLatitude = nan arcdeg
2025-03-11T17:09:29.605Z,1741712969.605 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakFDOMLongitude = nan arcdeg
2025-03-11T17:09:29.607Z,1741712969.607 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSalt = nan psu
2025-03-11T17:09:29.610Z,1741712969.610 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltDepth = nan m
2025-03-11T17:09:29.612Z,1741712969.612 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltTemperature = nan degC
2025-03-11T17:09:29.616Z,1741712969.616 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLatitude = nan arcdeg
2025-03-11T17:09:29.618Z,1741712969.618 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakSaltLongitude = nan arcdeg
2025-03-11T17:09:29.620Z,1741712969.620 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROI = nan count/s
2025-03-11T17:09:29.623Z,1741712969.623 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROIDepth = nan m
2025-03-11T17:09:29.625Z,1741712969.625 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROITemperature = nan degC
2025-03-11T17:09:29.627Z,1741712969.627 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg
2025-03-11T17:09:29.630Z,1741712969.630 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg
2025-03-11T17:09:29.633Z,1741712969.633 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROI = nan count/s
2025-03-11T17:09:29.636Z,1741712969.636 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROIDepth = nan m
2025-03-11T17:09:29.638Z,1741712969.638 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROITemperature = nan degC
2025-03-11T17:09:29.641Z,1741712969.641 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROILatitude = nan arcdeg
2025-03-11T17:09:29.643Z,1741712969.643 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.EdgePlanktivoreLMavgROILongitude = nan arcdeg
2025-03-11T17:09:29.646Z,1741712969.646 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROI = nan count/s
2025-03-11T17:09:29.648Z,1741712969.648 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROIDepth = nan m
2025-03-11T17:09:29.650Z,1741712969.650 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROITemperature = nan degC
2025-03-11T17:09:29.652Z,1741712969.652 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg
2025-03-11T17:09:29.655Z,1741712969.655 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg
2025-03-11T17:09:29.658Z,1741712969.658 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatoms = nan count/ml
2025-03-11T17:09:29.660Z,1741712969.660 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsDepth = nan m
2025-03-11T17:09:29.663Z,1741712969.663 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsTemperature = nan degC
2025-03-11T17:09:29.665Z,1741712969.665 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg
2025-03-11T17:09:29.667Z,1741712969.667 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg
2025-03-11T17:09:29.670Z,1741712969.670 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellates = nan count/ml
2025-03-11T17:09:29.672Z,1741712969.672 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesDepth = nan m
2025-03-11T17:09:29.675Z,1741712969.675 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC
2025-03-11T17:09:29.678Z,1741712969.678 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-03-11T17:09:29.681Z,1741712969.681 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-03-11T17:09:29.683Z,1741712969.683 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChl = nan ug/l
2025-03-11T17:09:29.686Z,1741712969.686 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDepth = nan m
2025-03-11T17:09:29.688Z,1741712969.688 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLatitude = nan arcdeg
2025-03-11T17:09:29.690Z,1741712969.690 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlLongitude = nan arcdeg
2025-03-11T17:09:29.692Z,1741712969.692 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchChlDistance = nan m
2025-03-11T17:09:29.695Z,1741712969.695 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSalt = nan psu
2025-03-11T17:09:29.697Z,1741712969.697 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDepth = nan m
2025-03-11T17:09:29.731Z,1741712969.731 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLatitude = nan arcdeg
2025-03-11T17:09:29.734Z,1741712969.734 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltLongitude = nan arcdeg
2025-03-11T17:09:29.736Z,1741712969.736 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchSaltDistance = nan m
2025-03-11T17:09:29.746Z,1741712969.746 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOil = nan psu
2025-03-11T17:09:29.749Z,1741712969.749 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDepth = nan m
2025-03-11T17:09:29.751Z,1741712969.751 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLatitude = nan arcdeg
2025-03-11T17:09:29.776Z,1741712969.776 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilLongitude = nan arcdeg
2025-03-11T17:09:29.791Z,1741712969.791 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.PatchOilDistance = nan m
2025-03-11T17:09:29.792Z,1741712969.792 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.TriggeredOnChl = 0 bool
2025-03-11T17:09:29.795Z,1741712969.795 [MissionManager](INFO): DefineOutput run_backseat_on_surface:Science.ChlTriggering = nan ug/l
2025-03-11T17:09:29.868Z,1741712969.868 [run_backseat_on_surface:Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:29.921Z,1741712969.921 [run_backseat_on_surface:Science:EdgeDetectChl:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-03-11T17:09:29.972Z,1741712969.972 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-03-11T17:09:29.991Z,1741712969.991 [run_backseat_on_surface:Science:PeakDetectNO3:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.002Z,1741712970.002 [run_backseat_on_surface:Science:PeakDetectOil:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.012Z,1741712970.012 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-03-11T17:09:30.025Z,1741712970.025 [run_backseat_on_surface:Science:PeakDetectFDOM:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.036Z,1741712970.036 [run_backseat_on_surface:Science:PeakDetectSalinity:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.048Z,1741712970.048 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-03-11T17:09:30.061Z,1741712970.061 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.073Z,1741712970.073 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-03-11T17:09:30.094Z,1741712970.094 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.106Z,1741712970.106 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.118Z,1741712970.118 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-03-11T17:09:30.129Z,1741712970.129 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2025-03-11T17:09:30.136Z,1741712970.136 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-03-11T17:09:30.136Z,1741712970.136 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-03-11T17:09:30.137Z,1741712970.137 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-03-11T17:09:30.156Z,1741712970.156 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-03-11T17:09:30.160Z,1741712970.160 [MissionManager](INFO): DefineArg run_backseat_on_surface:BackseatDriver.EnableBackseat = 0 bool
2025-03-11T17:09:30.162Z,1741712970.162 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-03-11T17:09:30.166Z,1741712970.166 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-03-11T17:09:30.166Z,1741712970.166 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-03-11T17:09:30.167Z,1741712970.167 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-03-11T17:09:30.311Z,1741712970.311 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-03-11T17:09:30.314Z,1741712970.314 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleAll = 0 bool
2025-03-11T17:09:30.316Z,1741712970.316 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad1 = 0 bool
2025-03-11T17:09:30.318Z,1741712970.318 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad2 = 0 bool
2025-03-11T17:09:30.320Z,1741712970.320 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.SampleLoad3 = 0 bool
2025-03-11T17:09:30.323Z,1741712970.323 [MissionManager](INFO): DefineArg run_backseat_on_surface:PowerOnly.EnabledPowerOnly = 1 bool
2025-03-11T17:09:30.331Z,1741712970.331 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-03-11T17:09:30.334Z,1741712970.334 [run_backseat_on_surface:E.GoToSurface](DEBUG): Construct GoToSurface.
2025-03-11T17:09:30.343Z,1741712970.343 [run_backseat_on_surface:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2025-03-11T17:09:30.345Z,1741712970.345 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Construct Wait.
2025-03-11T17:09:30.350Z,1741712970.350 [run_backseat_on_surface:H.Execute](DEBUG): Construct Execute.
2025-03-11T17:09:30.385Z,1741712970.385 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission run_backseat_on_surface {
arguments {
ElapsedSinceMissionStarted = 0 minute
}
# Power the science payload.
insert id="Science" Insert/Science.tl
# Power the Backseat payload.
insert Insert/BackseatDriver.tl
assign in sequence BackseatDriver:EnableBackseat = true
insert Insert/PowerOnly.tl
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P2H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceMissionStarted = elapsed ( Universal:mission_started )
syslog important "run_backseat_on_surface mission has been running for "
+ ElapsedSinceMissionStarted~minute
}
syslog important "Restarting logs and run_backseat_on_surface mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2025-03-11T17:09:30.387Z,1741712970.387 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/run_backseat_on_surface.tl
2025-03-11T17:09:30.660Z,1741712970.660 [MissionManager](IMPORTANT): Started mission run_backseat_on_surface
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface] Running Loop=1
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface](DEBUG): Aggregate::initialize run_backseat_on_surface
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science] Running Loop=1
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science](DEBUG): Aggregate::initialize run_backseat_on_surface:Science
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science:A] Running Loop=1
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science:B] Running Loop=1
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science:C] Running Loop=1
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science:D] Running Loop=1
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science:E] Running Loop=1
2025-03-11T17:09:30.660Z,1741712970.660 [run_backseat_on_surface:Science:F] Running Loop=1
2025-03-11T17:09:30.661Z,1741712970.661 [run_backseat_on_surface:Science:Read_Oil] Running Loop=1
2025-03-11T17:09:30.661Z,1741712970.661 [run_backseat_on_surface:Science:PeakDetectChl] Running Loop=1
2025-03-11T17:09:30.661Z,1741712970.661 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectChl
2025-03-11T17:09:30.661Z,1741712970.661 [run_backseat_on_surface:Science:PeakDetectChl:A] Running Loop=1
2025-03-11T17:09:30.661Z,1741712970.661 [run_backseat_on_surface:Science:EdgeDetectChl] Running Loop=1
2025-03-11T17:09:30.661Z,1741712970.661 [run_backseat_on_surface:Science:EdgeDetectChl](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectChl
2025-03-11T17:09:30.662Z,1741712970.662 [run_backseat_on_surface:Science:EdgeDetectChl:A] Running Loop=1
2025-03-11T17:09:30.662Z,1741712970.662 [run_backseat_on_surface:Science:HighestChlPeakReport] Running Loop=1
2025-03-11T17:09:30.662Z,1741712970.662 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestChlPeakReport
2025-03-11T17:09:30.662Z,1741712970.662 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-03-11T17:09:30.662Z,1741712970.662 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-03-11T17:09:30.662Z,1741712970.662 [run_backseat_on_surface:Science:PeakDetectNO3] Running Loop=1
2025-03-11T17:09:30.662Z,1741712970.662 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectNO3
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:PeakDetectNO3:A] Running Loop=1
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:PeakDetectOil] Running Loop=1
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectOil
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:PeakDetectOil:A] Running Loop=1
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:HighestOilPeakReport] Running Loop=1
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestOilPeakReport
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-03-11T17:09:30.663Z,1741712970.663 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:PeakDetectFDOM] Running Loop=1
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectFDOM
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:PeakDetectFDOM:A] Running Loop=1
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:PeakDetectSalinity] Running Loop=1
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectSalinity
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:PeakDetectSalinity:A] Running Loop=1
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:HighestSaltPeakReport] Running Loop=1
2025-03-11T17:09:30.664Z,1741712970.664 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:HighestSaltPeakReport
2025-03-11T17:09:30.665Z,1741712970.665 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-03-11T17:09:30.665Z,1741712970.665 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-03-11T17:09:30.665Z,1741712970.665 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-03-11T17:09:30.665Z,1741712970.665 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI
2025-03-11T17:09:30.665Z,1741712970.665 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI] Running Loop=1
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:A] Running Loop=1
2025-03-11T17:09:30.666Z,1741712970.666 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-03-11T17:09:30.667Z,1741712970.667 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates
2025-03-11T17:09:30.667Z,1741712970.667 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-03-11T17:09:30.667Z,1741712970.667 [run_backseat_on_surface:Science:ChlThreshTrigger] Running Loop=1
2025-03-11T17:09:30.667Z,1741712970.667 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:ChlThreshTrigger
2025-03-11T17:09:30.667Z,1741712970.667 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-03-11T17:09:30.667Z,1741712970.667 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:Science:OceanCurrent] Running Loop=1
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::initialize run_backseat_on_surface:Science:OceanCurrent
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::initialize run_backseat_on_surface:BackseatDriver
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-03-11T17:09:30.668Z,1741712970.668 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::initialize run_backseat_on_surface:PowerOnly
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:PowerOnly:A] Running Loop=1
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:PowerOnly:B] Running Loop=1
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:PowerOnly:C] Running Loop=1
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:PowerOnly:D] Running Loop=1
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:PowerOnly:E.Wait] Running Loop=1
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:E.GoToSurface] Running Loop=1
2025-03-11T17:09:30.669Z,1741712970.669 [run_backseat_on_surface:E.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-11T17:09:30.670Z,1741712970.670 [run_backseat_on_surface:E.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-11T17:09:30.670Z,1741712970.670 [run_backseat_on_surface:E.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-11T17:09:30.670Z,1741712970.670 [run_backseat_on_surface:E.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-11T17:09:30.671Z,1741712970.671 [run_backseat_on_surface:E.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-11T17:09:30.672Z,1741712970.672 [run_backseat_on_surface:E.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-11T17:09:30.674Z,1741712970.674 [run_backseat_on_surface:E.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-11T17:09:30.675Z,1741712970.675 [run_backseat_on_surface:C] Running Loop=1
2025-03-11T17:09:30.678Z,1741712970.678 [run_backseat_on_surface:PowerOnly] Running Loop=1
2025-03-11T17:09:30.678Z,1741712970.678 [run_backseat_on_surface:PowerOnly:D] Stopped
2025-03-11T17:09:30.678Z,1741712970.678 [run_backseat_on_surface:PowerOnly:C] Stopped
2025-03-11T17:09:30.678Z,1741712970.678 [run_backseat_on_surface:PowerOnly:B] Stopped
2025-03-11T17:09:30.678Z,1741712970.678 [run_backseat_on_surface:PowerOnly:A] Stopped
2025-03-11T17:09:30.678Z,1741712970.678 [run_backseat_on_surface:C] Stopped
2025-03-11T17:09:30.678Z,1741712970.678 [run_backseat_on_surface:BackseatDriver] Running Loop=1
2025-03-11T17:09:30.679Z,1741712970.679 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-03-11T17:09:30.694Z,1741712970.694 [run_backseat_on_surface:Science] Running Loop=1
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:ChlThreshTrigger] Stopped
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:ChlThreshTrigger
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDinoflagellates:A] Stopped
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-03-11T17:09:30.696Z,1741712970.696 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms
2025-03-11T17:09:30.697Z,1741712970.697 [run_backseat_on_surface:Science:PeakDetectPlanktivoreDiatoms:A] Stopped
2025-03-11T17:09:30.697Z,1741712970.697 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-03-11T17:09:30.697Z,1741712970.697 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI
2025-03-11T17:09:30.697Z,1741712970.697 [run_backseat_on_surface:Science:PeakDetectPlanktivoreHMavgROI:A] Stopped
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI] Stopped
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:EdgeDetectPlanktivoreLMavgROI:A] Stopped
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:PeakDetectPlanktivoreLMavgROI:A] Stopped
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:HighestSaltPeakReport] Stopped
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestSaltPeakReport
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-03-11T17:09:30.698Z,1741712970.698 [run_backseat_on_surface:Science:PeakDetectSalinity] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectSalinity
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectSalinity:A] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectFDOM] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectFDOM
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectFDOM:A] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:HighestOilPeakReport] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestOilPeakReport
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectOil] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectOil
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectOil:A] Stopped
2025-03-11T17:09:30.699Z,1741712970.699 [run_backseat_on_surface:Science:PeakDetectNO3] Stopped
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectNO3
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:PeakDetectNO3:A] Stopped
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:HighestChlPeakReport] Stopped
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:HighestChlPeakReport
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:EdgeDetectChl] Stopped
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:EdgeDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:EdgeDetectChl
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:EdgeDetectChl:A] Stopped
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:PeakDetectChl] Stopped
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:PeakDetectChl
2025-03-11T17:09:30.700Z,1741712970.700 [run_backseat_on_surface:Science:PeakDetectChl:A] Stopped
2025-03-11T17:09:30.701Z,1741712970.701 [run_backseat_on_surface:Science:OceanCurrent:A.] Running Loop=1
2025-03-11T17:09:30.701Z,1741712970.701 [run_backseat_on_surface:Science:Read_Oil] Stopped
2025-03-11T17:09:30.701Z,1741712970.701 [run_backseat_on_surface:Science:F] Stopped
2025-03-11T17:09:30.701Z,1741712970.701 [run_backseat_on_surface:Science:E] Running Loop=1
2025-03-11T17:09:30.702Z,1741712970.702 [run_backseat_on_surface:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2025-03-11T17:09:30.702Z,1741712970.702 [run_backseat_on_surface:Science:D] Stopped
2025-03-11T17:09:30.702Z,1741712970.702 [run_backseat_on_surface:Science:C] Running Loop=1
2025-03-11T17:09:30.702Z,1741712970.702 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2025-03-11T17:09:30.703Z,1741712970.703 [run_backseat_on_surface:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2025-03-11T17:09:30.703Z,1741712970.703 [run_backseat_on_surface:Science:B] Running Loop=1
2025-03-11T17:09:30.703Z,1741712970.703 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2025-03-11T17:09:30.704Z,1741712970.704 [run_backseat_on_surface:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2025-03-11T17:09:30.704Z,1741712970.704 [run_backseat_on_surface:Science:A] Stopped
2025-03-11T17:09:30.787Z,1741712970.787 [WetLabsBB2FL](INFO): Powering up
2025-03-11T17:09:31.062Z,1741712971.062 [run_backseat_on_surface:CheckIn] Running Loop=1
2025-03-11T17:09:31.062Z,1741712971.062 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2025-03-11T17:09:31.063Z,1741712971.063 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2025-03-11T17:09:31.465Z,1741712971.465 [run_backseat_on_surface:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-03-11T17:09:42.486Z,1741712982.486 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-03-11T17:09:42.486Z,1741712982.486 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-03-11T17:09:42.486Z,1741712982.486 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-03-11T17:10:00.861Z,1741713000.861 [BackseatComponent](INFO): Powering up
2025-03-11T17:10:00.862Z,1741713000.862 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-03-11T17:10:41.779Z,1741713041.779 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2025-03-11T17:10:41.779Z,1741713041.779 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:10:41.795Z,1741713041.795 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:10:42.203Z,1741713042.203 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:10:42.203Z,1741713042.203 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2025-03-11T17:10:59.307Z,1741713059.307 [BackseatComponent](IMPORTANT): ikshana: running backseat application.
2025-03-11T17:11:18.515Z,1741713078.515 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-03-11T17:11:18.515Z,1741713078.515 [NAL9602] Data Fault, FailCount= 4
2025-03-11T17:11:18.515Z,1741713078.515 [NAL9602](ERROR): Data Fault
2025-03-11T17:11:18.535Z,1741713078.535 [CBIT](ERROR): Data Fault in component: NAL9602
2025-03-11T17:11:18.920Z,1741713078.920 [NAL9602](INFO): Powering down
2025-03-11T17:11:19.763Z,1741713079.763 [CBIT](INFO): Clearing failed state for component NAL9602
2025-03-11T17:11:19.763Z,1741713079.763 [NAL9602] No Fault, FailCount= 4
2025-03-11T17:11:49.223Z,1741713109.223 [NAL9602](INFO): Powering up NAL9602
2025-03-11T17:12:00.131Z,1741713120.131 [NAL9602](INFO): NAL9602 initialized
2025-03-11T17:12:57.566Z,1741713177.566 [CommandExec](IMPORTANT): got command burn on
2025-03-11T17:12:57.566Z,1741713177.566 [CommandExec](IMPORTANT): Activating dropweight wire
2025-03-11T17:13:25.802Z,1741713205.802 [CommandExec](IMPORTANT): got command burn off
2025-03-11T17:13:25.802Z,1741713205.802 [CommandExec](IMPORTANT): Deactivating dropweight wire
2025-03-11T17:13:37.384Z,1741713217.384 [CommandLine](INFO): End of History
2025-03-11T17:13:37.446Z,1741713217.446 [CommandLine](INFO): End of History
2025-03-11T17:13:37.592Z,1741713217.592 [CommandLine](INFO): End of History
2025-03-11T17:13:37.666Z,1741713217.666 [CommandLine](INFO): End of History
2025-03-11T17:13:37.726Z,1741713217.726 [CommandLine](INFO): End of History
2025-03-11T17:13:37.785Z,1741713217.785 [CommandLine](INFO): End of History
2025-03-11T17:13:37.832Z,1741713217.832 [CommandLine](INFO): End of History
2025-03-11T17:13:42.765Z,1741713222.765 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2025-03-11T17:13:42.765Z,1741713222.765 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:13:42.783Z,1741713222.783 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:13:43.226Z,1741713223.226 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:13:43.226Z,1741713223.226 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2025-03-11T17:14:31.267Z,1741713271.267 [run_backseat_on_surface:CheckIn:Read_GPS](INFO): Timed out from 2025-03-11T17:09:31.1Z
2025-03-11T17:14:31.267Z,1741713271.267 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2025-03-11T17:14:31.267Z,1741713271.267 [run_backseat_on_surface:CheckIn:Read_Iridium] Running Loop=1
2025-03-11T17:14:31.642Z,1741713271.642 [run_backseat_on_surface:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-03-11T17:14:38.965Z,1741713278.965 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250311T162817/Courier0013.lzma
2025-03-11T17:14:39.967Z,1741713279.967 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Courier0013.lzma.bak
2025-03-11T17:14:39.968Z,1741713279.968 [DataOverHttps](INFO): SBD MOMSN=24177682
2025-03-11T17:14:55.878Z,1741713295.878 [DataOverHttps](INFO): Sending 384 bytes from file Logs/20250311T162817/Express0014.lzma
2025-03-11T17:14:56.883Z,1741713296.883 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Express0014.lzma.bak
2025-03-11T17:14:56.884Z,1741713296.884 [DataOverHttps](INFO): SBD MOMSN=24177685
2025-03-11T17:15:12.829Z,1741713312.829 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250311T162817/Express0017.lzma
2025-03-11T17:15:13.831Z,1741713313.831 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Express0017.lzma.bak
2025-03-11T17:15:13.831Z,1741713313.831 [DataOverHttps](INFO): SBD MOMSN=24177699
2025-03-11T17:15:14.879Z,1741713314.879 [run_backseat_on_surface:CheckIn:Read_Iridium] Stopped
2025-03-11T17:15:14.880Z,1741713314.880 [run_backseat_on_surface:CheckIn:C.Wait] Running Loop=1
2025-03-11T17:15:14.880Z,1741713314.880 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:16:43.774Z,1741713403.774 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2025-03-11T17:16:43.774Z,1741713403.774 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:16:43.814Z,1741713403.814 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:16:44.189Z,1741713404.189 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:16:44.189Z,1741713404.189 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2025-03-11T17:19:44.754Z,1741713584.754 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2025-03-11T17:19:44.754Z,1741713584.754 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:19:44.771Z,1741713584.771 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:19:45.183Z,1741713585.183 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:19:45.183Z,1741713585.183 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2025-03-11T17:20:15.451Z,1741713615.451 [run_backseat_on_surface:CheckIn:C.Wait](INFO): Done Waiting.
2025-03-11T17:20:15.451Z,1741713615.451 [run_backseat_on_surface:CheckIn:C.Wait] Stopped
2025-03-11T17:20:15.451Z,1741713615.451 [run_backseat_on_surface:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:20:15.452Z,1741713615.452 [run_backseat_on_surface:CheckIn:D] Running Loop=1
2025-03-11T17:20:15.867Z,1741713615.867 [run_backseat_on_surface:CheckIn:D] Stopped
2025-03-11T17:20:15.867Z,1741713615.867 [run_backseat_on_surface:CheckIn:E] Running Loop=1
2025-03-11T17:20:16.260Z,1741713616.260 [run_backseat_on_surface:CheckIn:E](IMPORTANT): run_backseat_on_surface mission has been running for 10.753447 min
2025-03-11T17:20:16.260Z,1741713616.260 [run_backseat_on_surface:CheckIn:E] Stopped
2025-03-11T17:20:16.261Z,1741713616.261 [run_backseat_on_surface:CheckIn](INFO): Completed run_backseat_on_surface:CheckIn
2025-03-11T17:20:16.261Z,1741713616.261 [run_backseat_on_surface:CheckIn] Stopped
2025-03-11T17:20:16.261Z,1741713616.261 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2025-03-11T17:20:16.261Z,1741713616.261 [run_backseat_on_surface:CheckIn](INFO): Running loop #2
2025-03-11T17:20:16.261Z,1741713616.261 [run_backseat_on_surface:CheckIn] Running Loop=2
2025-03-11T17:20:16.261Z,1741713616.261 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::initialize run_backseat_on_surface:CheckIn
2025-03-11T17:20:16.261Z,1741713616.261 [run_backseat_on_surface:CheckIn:Read_GPS] Running Loop=1
2025-03-11T17:20:59.607Z,1741713659.607 [BackseatComponent](CRITICAL): ikshana: Data dir size (66.43 GB) did not increase within 10 minutes
2025-03-11T17:20:59.607Z,1741713659.607 [BackseatComponent] Data Fault, FailCount= 1
2025-03-11T17:20:59.607Z,1741713659.607 [BackseatComponent](ERROR): Data Fault
2025-03-11T17:20:59.895Z,1741713659.895 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.data_dir_logging_rate with code: 1973
2025-03-11T17:20:59.921Z,1741713659.921 [CommandExec](FAULT): Scheduling is paused
2025-03-11T17:20:59.922Z,1741713659.922 [CBIT](INFO): Critical error at 20250311T172059
2025-03-11T17:20:59.922Z,1741713659.922 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-03-11T17:20:59.924Z,1741713659.924 [CBIT](ERROR): Data Fault in component: BackseatComponent
2025-03-11T17:21:00.010Z,1741713660.010 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-03-11T17:21:00.011Z,1741713660.011 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-03-11T17:21:00.319Z,1741713660.319 [MissionManager](INFO): MissionManager is completed.
2025-03-11T17:21:00.319Z,1741713660.319 [MissionManager](INFO): Uninitializing Mission run_backseat_on_surface
2025-03-11T17:21:00.319Z,1741713660.319 [run_backseat_on_surface] Stopped
2025-03-11T17:21:00.319Z,1741713660.319 [run_backseat_on_surface](DEBUG): Aggregate::uninitialize run_backseat_on_surface
2025-03-11T17:21:00.319Z,1741713660.319 [run_backseat_on_surface:Science] Stopped
2025-03-11T17:21:00.319Z,1741713660.319 [run_backseat_on_surface:Science](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:Science:B] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:Science:C] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:Science:E] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:Science:OceanCurrent] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:Science:OceanCurrent](DEBUG): Aggregate::uninitialize run_backseat_on_surface:Science:OceanCurrent
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:Science:OceanCurrent:A.] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:BackseatDriver] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:BackseatDriver](DEBUG): Aggregate::uninitialize run_backseat_on_surface:BackseatDriver
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:BackseatDriver:A.BackseatDriver] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:PowerOnly] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:PowerOnly](DEBUG): Aggregate::uninitialize run_backseat_on_surface:PowerOnly
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:PowerOnly:E.Wait] Stopped
2025-03-11T17:21:00.320Z,1741713660.320 [run_backseat_on_surface:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:21:00.321Z,1741713660.321 [run_backseat_on_surface:E.GoToSurface] Stopped
2025-03-11T17:21:00.321Z,1741713660.321 [run_backseat_on_surface:E.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-11T17:21:00.321Z,1741713660.321 [run_backseat_on_surface:CheckIn] Stopped
2025-03-11T17:21:00.321Z,1741713660.321 [run_backseat_on_surface:CheckIn](DEBUG): Aggregate::uninitialize run_backseat_on_surface:CheckIn
2025-03-11T17:21:00.337Z,1741713660.337 [run_backseat_on_surface:CheckIn:Read_GPS] Stopped
2025-03-11T17:21:00.597Z,1741713660.597 [WetLabsBB2FL](INFO): Powering down
2025-03-11T17:21:00.723Z,1741713660.723 [MissionManager](IMPORTANT): Started mission Default
2025-03-11T17:21:00.723Z,1741713660.723 [Default] Running Loop=1
2025-03-11T17:21:00.724Z,1741713660.724 [Default](DEBUG): Aggregate::initialize Default
2025-03-11T17:21:00.724Z,1741713660.724 [Default:B.GoToSurface] Running Loop=1
2025-03-11T17:21:00.724Z,1741713660.724 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-11T17:21:00.724Z,1741713660.724 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-11T17:21:00.724Z,1741713660.724 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-11T17:21:00.724Z,1741713660.724 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-11T17:21:00.725Z,1741713660.725 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-11T17:21:00.725Z,1741713660.725 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-11T17:21:00.726Z,1741713660.726 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-11T17:21:00.726Z,1741713660.726 [Default:A.Wait] Running Loop=1
2025-03-11T17:21:00.726Z,1741713660.726 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:21:14.055Z,1741713674.055 [Default:A.Wait](INFO): Done Waiting.
2025-03-11T17:21:14.055Z,1741713674.055 [Default:A.Wait] Stopped
2025-03-11T17:21:14.055Z,1741713674.055 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:21:14.448Z,1741713674.448 [Default:CheckIn] Running Loop=1
2025-03-11T17:21:14.448Z,1741713674.448 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-03-11T17:21:14.448Z,1741713674.448 [Default:CheckIn:Read_GPS] Running Loop=1
2025-03-11T17:21:18.190Z,1741713678.190 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-03-11T17:21:18.190Z,1741713678.190 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-03-11T17:21:18.190Z,1741713678.190 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-03-11T17:21:37.118Z,1741713697.118 [CBIT](INFO): Clearing failed state for component BackseatComponent
2025-03-11T17:21:37.119Z,1741713697.119 [BackseatComponent] No Fault, FailCount= 0
2025-03-11T17:21:37.177Z,1741713697.177 [BackseatComponent](INFO): Powering up
2025-03-11T17:21:37.178Z,1741713697.178 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-03-11T17:21:58.078Z,1741713718.078 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-03-11T17:21:58.078Z,1741713718.078 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-03-11T17:22:01.291Z,1741713721.291 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-03-11T17:22:01.291Z,1741713721.291 [NAL9602] Data Fault, FailCount= 5
2025-03-11T17:22:01.291Z,1741713721.291 [NAL9602](ERROR): Data Fault
2025-03-11T17:22:01.309Z,1741713721.309 [CBIT](ERROR): Data Fault in component: NAL9602
2025-03-11T17:22:01.310Z,1741713721.310 [CBIT](CRITICAL): Data Fault in component: NAL9602
2025-03-11T17:22:01.699Z,1741713721.699 [NAL9602](INFO): Powering down
2025-03-11T17:22:01.735Z,1741713721.735 [CBIT](INFO): Critical error at 20250311T172201
2025-03-11T17:22:16.242Z,1741713736.242 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-03-11T17:22:16.242Z,1741713736.242 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-03-11T17:22:16.242Z,1741713736.242 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-03-11T17:22:45.739Z,1741713765.739 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2025-03-11T17:22:45.739Z,1741713765.739 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:22:45.750Z,1741713765.750 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:22:46.164Z,1741713766.164 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:22:46.165Z,1741713766.165 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2025-03-11T17:24:01.304Z,1741713841.304 [CBIT](INFO): Clearing failed state for component NAL9602
2025-03-11T17:24:01.304Z,1741713841.304 [NAL9602] No Fault, FailCount= 5
2025-03-11T17:24:01.679Z,1741713841.679 [NAL9602](INFO): Powering up NAL9602
2025-03-11T17:24:12.587Z,1741713852.587 [NAL9602](INFO): NAL9602 initialized
2025-03-11T17:25:46.730Z,1741713946.730 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2025-03-11T17:25:46.730Z,1741713946.730 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:25:46.741Z,1741713946.741 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:25:47.147Z,1741713947.147 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:25:47.147Z,1741713947.147 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2025-03-11T17:26:14.615Z,1741713974.615 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-03-11T17:21:14.4Z
2025-03-11T17:26:14.615Z,1741713974.615 [Default:CheckIn:Read_GPS] Stopped
2025-03-11T17:26:14.615Z,1741713974.615 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-03-11T17:26:15.010Z,1741713975.010 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-03-11T17:26:22.321Z,1741713982.321 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20250311T162817/Courier0019.lzma
2025-03-11T17:26:23.323Z,1741713983.323 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Courier0019.lzma.bak
2025-03-11T17:26:23.323Z,1741713983.323 [DataOverHttps](INFO): SBD MOMSN=24178088
2025-03-11T17:26:39.093Z,1741713999.093 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20250311T162817/Express0020.lzma
2025-03-11T17:26:40.104Z,1741714000.104 [DataOverHttps](INFO): Moved sent file to Logs/20250311T162817/Express0020.lzma.bak
2025-03-11T17:26:40.104Z,1741714000.104 [DataOverHttps](INFO): SBD MOMSN=24178092
2025-03-11T17:26:41.272Z,1741714001.272 [Default:CheckIn:Read_Iridium] Stopped
2025-03-11T17:26:41.272Z,1741714001.272 [Default:CheckIn:C.Wait] Running Loop=1
2025-03-11T17:26:41.272Z,1741714001.272 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:28:34.699Z,1741714114.699 [DataOverHttps](IMPORTANT): SBD MTMSN=20250311T172833
2025-03-11T17:28:41.949Z,1741714121.949 [DataOverHttps](INFO): Received command: load Engineering/lab_test_optim.tl;set lab_test_optim.RecordTime 13 min;run
2025-03-11T17:28:41.992Z,1741714121.992 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/lab_test_optim.tl
2025-03-11T17:28:41.993Z,1741714121.993 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/lab_test_optim.tl
2025-03-11T17:28:41.993Z,1741714121.993 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/lab_test_optim.tl
2025-03-11T17:28:42.010Z,1741714122.010 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/lab_test_optim.tl
2025-03-11T17:28:42.300Z,1741714122.300 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/lab_test_optim.tl translated into:
15
1
30
2
100
100
Waiting
for backseat to start up...
Trying to run Optim and Multiray forreal
1
Setting multiray red brightness to
2
Setting muliray white brightness to
Recording for
2025-03-11T17:28:42.304Z,1741714122.304 [MissionManager](INFO): DefineArg lab_test_optim.MissionTimeout = 15.000000 min
2025-03-11T17:28:42.307Z,1741714122.307 [MissionManager](INFO): DefineArg lab_test_optim.RecordTime = 1.000000 min
2025-03-11T17:28:42.309Z,1741714122.309 [MissionManager](INFO): DefineArg lab_test_optim.BackseatWait = 30.000000 s
2025-03-11T17:28:42.332Z,1741714122.332 [MissionManager](INFO): DefineArg lab_test_optim.LightMode = 2.000000 count
2025-03-11T17:28:42.334Z,1741714122.334 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessWhite = 100.000000 n/a int32
2025-03-11T17:28:42.336Z,1741714122.336 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessRed = 100.000000 n/a int32
2025-03-11T17:28:42.338Z,1741714122.338 [MissionManager](INFO): DefineOutput lab_test_optim.RecordingEnabled = 0 bool
2025-03-11T17:28:42.340Z,1741714122.340 [MissionManager](INFO): DefineOutput lab_test_optim.LightsEnabled = 0 bool
2025-03-11T17:28:42.341Z,1741714122.341 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-03-11T17:28:42.341Z,1741714122.341 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-03-11T17:28:42.342Z,1741714122.342 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-03-11T17:28:42.401Z,1741714122.401 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-03-11T17:28:42.404Z,1741714122.404 [MissionManager](INFO): DefineArg lab_test_optim:BackseatDriver.EnableBackseat = 0 bool
2025-03-11T17:28:42.407Z,1741714122.407 [lab_test_optim:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-03-11T17:28:42.423Z,1741714122.423 [lab_test_optim:Startup:B.Wait](DEBUG): Construct Wait.
2025-03-11T17:28:42.439Z,1741714122.439 [lab_test_optim:Run:H.Wait](DEBUG): Construct Wait.
2025-03-11T17:28:42.440Z,1741714122.440 [lab_test_optim:G.Wait](DEBUG): Construct Wait.
2025-03-11T17:28:42.462Z,1741714122.462 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission lab_test_optim {
arguments {
MissionTimeout = 15 minute
"""
Backseat will stay on for this duration, independent of Optim state
"""
RecordTime = 1 minute
"""
How long to record after startup sequence (hopefully) turns on Optim camera
"""
BackseatWait = 30 second
"""
How long to wait for the backseat to power up before attempting to power the Optim
"""
LightMode = 2 count
"""
Mode for Multiray lights. 0 is off, 1 is red, 2 is white
"""
BrightnessWhite = 100 none_int
"""
White Multiray LED brightness, 0-100
"""
BrightnessRed = 100 none_int
"""
Red Multiray LED brightness, 0-100
"""
}
output {
RecordingEnabled = false
LightsEnabled = false
}
timeout duration=MissionTimeout
insert Insert/BackseatDriver.tl
assign in parallel BackseatDriver:EnableBackseat = true
readData strategy="MinError" {
while ( RecordingEnabled )
Sensor:PowerOnly.sampleLoad1
}
readData strategy="MinError" {
while ( LightsEnabled )
Sensor:MultiRay.lightModeLog
}
aggregate Startup {
run in sequence
syslog important "Waiting " + BackseatWait~s + " for backseat to start up..."
behavior Guidance:Wait {
run in sequence
set duration = BackseatWait
}
}
aggregate Run {
run in sequence
syslog important "Trying to run Optim and Multiray forreal"
assign in sequence RecordingEnabled = true
assign in sequence LightsEnabled = true
assign in sequence Sensor:MultiRay.lightModeCommand = LightMode
aggregate setRed {
run in sequence
break if ( LightMode != 1 count )
assign in sequence Sensor:MultiRay.brightnessRed = BrightnessRed
syslog info "Setting multiray red brightness to" + BrightnessRed~count
}
aggregate setWhite {
run in sequence
break if ( LightMode != 2 count )
assign in sequence Sensor:MultiRay.brightnessWhite = BrightnessWhite
syslog info "Setting muliray white brightness to" + BrightnessWhite~count
}
syslog important "Recording for " + RecordTime~min
behavior Guidance:Wait {
run in sequence
set duration = RecordTime
}
}
behavior Guidance:Wait {
run in sequence
set duration = MissionTimeout
}
}
2025-03-11T17:28:42.462Z,1741714122.462 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/lab_test_optim.tl id=lab_test_optim
2025-03-11T17:28:45.840Z,1741714125.840 [CommandExec](IMPORTANT): got command set lab_test_optim.RecordTime 13 minute
2025-03-11T17:28:45.841Z,1741714125.841 [CommandExec](IMPORTANT): got command run
2025-03-11T17:28:45.842Z,1741714125.842 [CommandExec](IMPORTANT): Running
2025-03-11T17:28:46.138Z,1741714126.138 [Default] Stopped
2025-03-11T17:28:46.138Z,1741714126.138 [Default](DEBUG): Aggregate::uninitialize Default
2025-03-11T17:28:46.138Z,1741714126.138 [Default:B.GoToSurface] Stopped
2025-03-11T17:28:46.139Z,1741714126.139 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-11T17:28:46.139Z,1741714126.139 [Default:CheckIn] Stopped
2025-03-11T17:28:46.139Z,1741714126.139 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-03-11T17:28:46.139Z,1741714126.139 [Default:CheckIn:C.Wait] Stopped
2025-03-11T17:28:46.139Z,1741714126.139 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:28:46.139Z,1741714126.139 [MissionManager](IMPORTANT): Started mission lab_test_optim
2025-03-11T17:28:46.139Z,1741714126.139 [lab_test_optim] Running Loop=1
2025-03-11T17:28:46.139Z,1741714126.139 [lab_test_optim](DEBUG): Aggregate::initialize lab_test_optim
2025-03-11T17:28:46.139Z,1741714126.139 [lab_test_optim:BackseatDriver] Running Loop=1
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::initialize lab_test_optim:BackseatDriver
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:B] Running Loop=1
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:C] Running Loop=1
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:D] Running Loop=1
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:Startup] Running Loop=1
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:Startup](DEBUG): Aggregate::initialize lab_test_optim:Startup
2025-03-11T17:28:46.140Z,1741714126.140 [lab_test_optim:Startup:A] Running Loop=1
2025-03-11T17:28:46.141Z,1741714126.141 [lab_test_optim:Startup:A](IMPORTANT): Waiting 30.000000 s for backseat to start up...
2025-03-11T17:28:46.141Z,1741714126.141 [lab_test_optim:Startup:A] Stopped
2025-03-11T17:28:46.141Z,1741714126.141 [lab_test_optim:Startup:B.Wait] Running Loop=1
2025-03-11T17:28:46.142Z,1741714126.142 [lab_test_optim:Startup:B.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:28:46.142Z,1741714126.142 [lab_test_optim:D] Stopped
2025-03-11T17:28:46.142Z,1741714126.142 [lab_test_optim:C] Stopped
2025-03-11T17:28:46.142Z,1741714126.142 [lab_test_optim:B] Running Loop=1
2025-03-11T17:28:46.142Z,1741714126.142 [lab_test_optim:BackseatDriver] Running Loop=1
2025-03-11T17:28:46.142Z,1741714126.142 [lab_test_optim:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2025-03-11T17:28:46.281Z,1741714126.281 [BackseatComponent](INFO): Powering up
2025-03-11T17:28:46.282Z,1741714126.282 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-03-11T17:28:47.723Z,1741714127.723 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2025-03-11T17:28:47.723Z,1741714127.723 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:28:47.783Z,1741714127.783 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:28:48.161Z,1741714128.161 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:28:48.162Z,1741714128.162 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Startup:B.Wait](INFO): Done Waiting.
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Startup:B.Wait] Stopped
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Startup:B.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Startup](INFO): Completed lab_test_optim:Startup
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Startup] Stopped
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Startup](DEBUG): Aggregate::uninitialize lab_test_optim:Startup
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Run] Running Loop=1
2025-03-11T17:29:16.830Z,1741714156.830 [lab_test_optim:Run](DEBUG): Aggregate::initialize lab_test_optim:Run
2025-03-11T17:29:16.831Z,1741714156.831 [lab_test_optim:Run:A] Running Loop=1
2025-03-11T17:29:17.251Z,1741714157.251 [lab_test_optim:Run:A](IMPORTANT): Trying to run Optim and Multiray forreal
2025-03-11T17:29:17.251Z,1741714157.251 [lab_test_optim:Run:A] Stopped
2025-03-11T17:29:17.251Z,1741714157.251 [lab_test_optim:Run:B] Running Loop=1
2025-03-11T17:29:17.655Z,1741714157.655 [lab_test_optim:Run:B] Stopped
2025-03-11T17:29:17.655Z,1741714157.655 [lab_test_optim:Run:C] Running Loop=1
2025-03-11T17:29:18.027Z,1741714158.027 [lab_test_optim:Run:C] Stopped
2025-03-11T17:29:18.028Z,1741714158.028 [lab_test_optim:Run:D] Running Loop=1
2025-03-11T17:29:18.028Z,1741714158.028 [lab_test_optim:C] Running Loop=1
2025-03-11T17:29:18.028Z,1741714158.028 [lab_test_optim:C] Running Loop=1
2025-03-11T17:29:18.028Z,1741714158.028 [lab_test_optim:C](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1
2025-03-11T17:29:18.424Z,1741714158.424 [PowerOnly](INFO): Powering up loadControl
2025-03-11T17:29:18.449Z,1741714158.449 [lab_test_optim:Run:D] Stopped
2025-03-11T17:29:18.449Z,1741714158.449 [lab_test_optim:Run:setRed] Running Loop=1
2025-03-11T17:29:18.449Z,1741714158.449 [lab_test_optim:Run:setRed](DEBUG): Aggregate::initialize lab_test_optim:Run:setRed
2025-03-11T17:29:18.449Z,1741714158.449 [lab_test_optim:Run:setRed:A] Running Loop=1
2025-03-11T17:29:18.450Z,1741714158.450 [lab_test_optim:D] Running Loop=1
2025-03-11T17:29:18.450Z,1741714158.450 [lab_test_optim:D] Running Loop=1
2025-03-11T17:29:18.450Z,1741714158.450 [lab_test_optim:D](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2025-03-11T17:29:18.840Z,1741714158.840 [lab_test_optim:Run:setRed] Stopped
2025-03-11T17:29:18.840Z,1741714158.840 [lab_test_optim:Run:setRed](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setRed
2025-03-11T17:29:18.840Z,1741714158.840 [lab_test_optim:Run:setRed:A] Stopped
2025-03-11T17:29:18.840Z,1741714158.840 [lab_test_optim:Run:setWhite] Running Loop=1
2025-03-11T17:29:18.840Z,1741714158.840 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::initialize lab_test_optim:Run:setWhite
2025-03-11T17:29:18.841Z,1741714158.841 [lab_test_optim:Run:setWhite:A] Running Loop=1
2025-03-11T17:29:19.256Z,1741714159.256 [lab_test_optim:Run:setWhite:A] Stopped
2025-03-11T17:29:19.256Z,1741714159.256 [lab_test_optim:Run:setWhite:B] Running Loop=1
2025-03-11T17:29:19.676Z,1741714159.676 [lab_test_optim:Run:setWhite:B](INFO): Setting muliray white brightness to 100.000000 count
2025-03-11T17:29:19.676Z,1741714159.676 [lab_test_optim:Run:setWhite:B] Stopped
2025-03-11T17:29:19.676Z,1741714159.676 [lab_test_optim:Run:setWhite](INFO): Completed lab_test_optim:Run:setWhite
2025-03-11T17:29:19.676Z,1741714159.676 [lab_test_optim:Run:setWhite] Stopped
2025-03-11T17:29:19.676Z,1741714159.676 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setWhite
2025-03-11T17:29:19.676Z,1741714159.676 [lab_test_optim:Run:G] Running Loop=1
2025-03-11T17:29:20.068Z,1741714160.068 [lab_test_optim:Run:G](IMPORTANT): Recording for 13.000000 min
2025-03-11T17:29:20.068Z,1741714160.068 [lab_test_optim:Run:G] Stopped
2025-03-11T17:29:20.068Z,1741714160.068 [lab_test_optim:Run:H.Wait] Running Loop=1
2025-03-11T17:29:20.068Z,1741714160.068 [lab_test_optim:Run:H.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:29:20.847Z,1741714160.847 [MultiRay](IMPORTANT): MultiRay white lights ON
2025-03-11T17:29:44.311Z,1741714184.311 [BackseatComponent](IMPORTANT): ikshana: running backseat application.
2025-03-11T17:31:48.736Z,1741714308.736 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2025-03-11T17:31:48.736Z,1741714308.736 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:31:48.749Z,1741714308.749 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:31:49.154Z,1741714309.154 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:31:49.154Z,1741714309.154 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2025-03-11T17:34:13.758Z,1741714453.758 [NAL9602](FAULT): GPS failed to acquire within timeout.
2025-03-11T17:34:13.759Z,1741714453.759 [NAL9602] Data Fault, FailCount= 1
2025-03-11T17:34:13.759Z,1741714453.759 [NAL9602](ERROR): Data Fault
2025-03-11T17:34:13.789Z,1741714453.789 [CBIT](ERROR): Data Fault in component: NAL9602
2025-03-11T17:34:14.179Z,1741714454.179 [NAL9602](INFO): Powering down
2025-03-11T17:34:15.022Z,1741714455.022 [CBIT](INFO): Clearing failed state for component NAL9602
2025-03-11T17:34:15.022Z,1741714455.022 [NAL9602] No Fault, FailCount= 1
2025-03-11T17:34:44.491Z,1741714484.491 [NAL9602](INFO): Powering up NAL9602
2025-03-11T17:34:49.794Z,1741714489.794 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2025-03-11T17:34:49.794Z,1741714489.794 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:34:49.805Z,1741714489.805 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:34:50.188Z,1741714490.188 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:34:50.188Z,1741714490.188 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2025-03-11T17:34:55.371Z,1741714495.371 [NAL9602](INFO): NAL9602 initialized
2025-03-11T17:37:50.754Z,1741714670.754 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2025-03-11T17:37:50.754Z,1741714670.754 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:37:50.765Z,1741714670.765 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:37:51.173Z,1741714671.173 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:37:51.173Z,1741714671.173 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2025-03-11T17:39:44.319Z,1741714784.319 [BackseatComponent](CRITICAL): ikshana: Data dir size (76.43 GB) did not increase within 10 minutes
2025-03-11T17:39:44.319Z,1741714784.319 [BackseatComponent] Data Fault, FailCount= 1
2025-03-11T17:39:44.319Z,1741714784.319 [BackseatComponent](ERROR): Data Fault
2025-03-11T17:39:44.651Z,1741714784.651 [lab_test_optim:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.data_dir_logging_rate with code: 1973
2025-03-11T17:39:44.675Z,1741714784.675 [CBIT](INFO): Critical error at 20250311T173944
2025-03-11T17:39:44.675Z,1741714784.675 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2025-03-11T17:39:44.678Z,1741714784.678 [CBIT](ERROR): Data Fault in component: BackseatComponent
2025-03-11T17:39:44.723Z,1741714784.723 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-03-11T17:39:44.723Z,1741714784.723 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-03-11T17:39:45.057Z,1741714785.057 [MissionManager](INFO): MissionManager is completed.
2025-03-11T17:39:45.057Z,1741714785.057 [MissionManager](INFO): Uninitializing Mission lab_test_optim
2025-03-11T17:39:45.057Z,1741714785.057 [lab_test_optim] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim](DEBUG): Aggregate::uninitialize lab_test_optim
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:BackseatDriver] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::uninitialize lab_test_optim:BackseatDriver
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:BackseatDriver:A.BackseatDriver] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:B] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:C] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:D] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:Run] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:Run](DEBUG): Aggregate::uninitialize lab_test_optim:Run
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:Run:H.Wait] Stopped
2025-03-11T17:39:45.058Z,1741714785.058 [lab_test_optim:Run:H.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:39:45.483Z,1741714785.483 [MissionManager](IMPORTANT): Started mission Default
2025-03-11T17:39:45.483Z,1741714785.483 [Default] Running Loop=1
2025-03-11T17:39:45.484Z,1741714785.484 [Default](DEBUG): Aggregate::initialize Default
2025-03-11T17:39:45.484Z,1741714785.484 [Default:B.GoToSurface] Running Loop=1
2025-03-11T17:39:45.484Z,1741714785.484 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-03-11T17:39:45.484Z,1741714785.484 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-03-11T17:39:45.484Z,1741714785.484 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-03-11T17:39:45.485Z,1741714785.485 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-03-11T17:39:45.485Z,1741714785.485 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-03-11T17:39:45.485Z,1741714785.485 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-03-11T17:39:45.486Z,1741714785.486 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-03-11T17:39:45.486Z,1741714785.486 [Default:A.Wait] Running Loop=1
2025-03-11T17:39:45.486Z,1741714785.486 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-03-11T17:39:58.800Z,1741714798.800 [Default:A.Wait](INFO): Done Waiting.
2025-03-11T17:39:58.800Z,1741714798.800 [Default:A.Wait] Stopped
2025-03-11T17:39:58.800Z,1741714798.800 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-03-11T17:39:59.197Z,1741714799.197 [Default:CheckIn] Running Loop=1
2025-03-11T17:39:59.197Z,1741714799.197 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-03-11T17:39:59.197Z,1741714799.197 [Default:CheckIn:Read_GPS] Running Loop=1
2025-03-11T17:40:02.906Z,1741714802.906 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-03-11T17:40:02.906Z,1741714802.906 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-03-11T17:40:02.906Z,1741714802.906 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-03-11T17:40:21.860Z,1741714821.860 [CBIT](INFO): Clearing failed state for component BackseatComponent
2025-03-11T17:40:21.860Z,1741714821.860 [BackseatComponent] No Fault, FailCount= 0
2025-03-11T17:40:21.893Z,1741714821.893 [BackseatComponent](INFO): Powering up
2025-03-11T17:40:21.894Z,1741714821.894 [BackseatComponent](INFO): Subscribing to LCM channels.
2025-03-11T17:40:42.790Z,1741714842.790 [BackseatComponent](INFO): Sent LCM shutdown request.
2025-03-11T17:40:42.791Z,1741714842.791 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2025-03-11T17:40:51.750Z,1741714851.750 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2025-03-11T17:40:51.750Z,1741714851.750 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-03-11T17:40:51.760Z,1741714851.760 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-03-11T17:40:52.167Z,1741714852.167 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-03-11T17:40:52.167Z,1741714852.167 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2025-03-11T17:41:00.973Z,1741714860.973 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2025-03-11T17:41:00.974Z,1741714860.974 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2025-03-11T17:41:00.974Z,1741714860.974 [LcmUniversalReporter](INFO): Deactivating messaging.
2025-03-11T17:41:15.539Z,1741714875.539 [PowerOnly](INFO): Powering down loadControl
2025-03-11T17:43:36.138Z,1741715016.138 [CommandExec](IMPORTANT): got command configSet CBIT.gfScanTimeout 3 minute persist
2025-03-11T17:43:36.169Z,1741715016.169 [CommandExec](IMPORTANT): got command restart application
2025-03-11T17:43:36.182Z,1741715016.182 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-03-11T17:43:37.173Z,1741715017.173 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:37.173Z,1741715017.173 [CommandExec](INFO): Uninitializing the command executive.
2025-03-11T17:43:37.173Z,1741715017.173 [CommandExec](INFO): Uninitializing the command scheduler.
2025-03-11T17:43:37.174Z,1741715017.174 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:37.345Z,1741715017.345 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2025-03-11T17:43:37.345Z,1741715017.345 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2025-03-11T17:43:37.345Z,1741715017.345 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:37.346Z,1741715017.346 [NavChartDb](INFO): Join timeout helper Thread ID is 3749
2025-03-11T17:43:37.466Z,1741715017.466 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:37.467Z,1741715017.467 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:37.485Z,1741715017.485 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2025-03-11T17:43:37.485Z,1741715017.485 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:37.486Z,1741715017.486 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3750
2025-03-11T17:43:37.677Z,1741715017.677 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:37.678Z,1741715017.678 [WetLabsBB2FL](INFO): Powering down
2025-03-11T17:43:37.678Z,1741715017.678 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:37.685Z,1741715017.685 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2025-03-11T17:43:37.685Z,1741715017.685 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:37.686Z,1741715017.686 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3751
2025-03-11T17:43:38.361Z,1741715018.361 [CTD_Seabird](INFO): Powering down
2025-03-11T17:43:38.373Z,1741715018.373 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:38.373Z,1741715018.373 [CTD_Seabird](INFO): Powering down
2025-03-11T17:43:38.385Z,1741715018.385 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:38.386Z,1741715018.386 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2025-03-11T17:43:38.386Z,1741715018.386 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:38.386Z,1741715018.386 [Radio_Surface](INFO): Join timeout helper Thread ID is 3752
2025-03-11T17:43:38.749Z,1741715018.749 [Radio_Surface](INFO): Powering down
2025-03-11T17:43:38.750Z,1741715018.750 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:38.751Z,1741715018.751 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:38.757Z,1741715018.757 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2025-03-11T17:43:38.757Z,1741715018.757 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:38.758Z,1741715018.758 [Onboard](INFO): Join timeout helper Thread ID is 3753
2025-03-11T17:43:39.649Z,1741715019.649 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-03-11T17:43:40.623Z,1741715020.623 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.002542
CHAN A1 (24V): 0.000469
CHAN A2 (12V): -0.005414
CHAN A3 (5V): -0.002234
CHAN B0 (3.3V): -0.000883
CHAN B1 (3.15aV): -0.001420
CHAN B2 (3.15bV): -0.001063
CHAN B3 (GND): -0.000742
OPEN: 0.004956
Full Scale: +/- 1 mA
2025-03-11T17:43:41.025Z,1741715021.025 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-03-11T17:43:42.450Z,1741715022.450 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:42.450Z,1741715022.450 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.471Z,1741715022.471 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2025-03-11T17:43:42.471Z,1741715022.471 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.472Z,1741715022.472 [DataOverHttps](INFO): Join timeout helper Thread ID is 3754
2025-03-11T17:43:42.671Z,1741715022.671 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:42.672Z,1741715022.672 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.674Z,1741715022.674 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2025-03-11T17:43:42.674Z,1741715022.674 [DAT ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.674Z,1741715022.674 [DAT](INFO): Join timeout helper Thread ID is 3755
2025-03-11T17:43:42.761Z,1741715022.761 [DAT](INFO): Powering down
2025-03-11T17:43:42.834Z,1741715022.834 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:42.834Z,1741715022.834 [DAT](INFO): Powering down
2025-03-11T17:43:42.835Z,1741715022.835 [DAT ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.854Z,1741715022.854 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2025-03-11T17:43:42.854Z,1741715022.854 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.854Z,1741715022.854 [BackseatComponent](INFO): Join timeout helper Thread ID is 3756
2025-03-11T17:43:42.897Z,1741715022.897 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:42.898Z,1741715022.898 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.914Z,1741715022.914 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2025-03-11T17:43:42.914Z,1741715022.914 [logger ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.914Z,1741715022.914 [logger](INFO): Join timeout helper Thread ID is 3757
2025-03-11T17:43:42.925Z,1741715022.925 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:42.926Z,1741715022.926 [logger ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.934Z,1741715022.934 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2025-03-11T17:43:42.934Z,1741715022.934 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.934Z,1741715022.934 [CommandLine](INFO): Join timeout helper Thread ID is 3758
2025-03-11T17:43:42.957Z,1741715022.957 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:42.958Z,1741715022.958 [CommandLine ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.974Z,1741715022.974 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2025-03-11T17:43:42.974Z,1741715022.974 [CommandExec ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.974Z,1741715022.974 [CommandExec](INFO): Join timeout helper Thread ID is 3759
2025-03-11T17:43:42.975Z,1741715022.975 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2025-03-11T17:43:42.975Z,1741715022.975 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:42.976Z,1741715022.976 [controlThread](INFO): Join timeout helper Thread ID is 3760
2025-03-11T17:43:42.986Z,1741715022.986 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2025-03-11T17:43:42.986Z,1741715022.986 [controlThread](DEBUG): Uninitializing ControlThread
2025-03-11T17:43:42.986Z,1741715022.986 [AHRS_M2](INFO): Powering down
2025-03-11T17:43:43.054Z,1741715023.054 [MultiRay](INFO): Powering down.
2025-03-11T17:43:43.055Z,1741715023.055 [NAL9602](INFO): Powering down
2025-03-11T17:43:43.057Z,1741715023.057 [Waterlinked](INFO): Powering down
2025-03-11T17:43:43.058Z,1741715023.058 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2025-03-11T17:43:43.059Z,1741715023.059 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2025-03-11T17:43:43.059Z,1741715023.059 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2025-03-11T17:43:43.060Z,1741715023.060 [MissionManager](INFO): Uninitializing Mission Default
2025-03-11T17:43:43.060Z,1741715023.060 [Default] Stopped
2025-03-11T17:43:43.060Z,1741715023.060 [Default](DEBUG): Aggregate::uninitialize Default
2025-03-11T17:43:43.060Z,1741715023.060 [Default:B.GoToSurface] Stopped
2025-03-11T17:43:43.060Z,1741715023.060 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-03-11T17:43:43.060Z,1741715023.060 [Default:CheckIn] Stopped
2025-03-11T17:43:43.060Z,1741715023.060 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-03-11T17:43:43.060Z,1741715023.060 [Default:CheckIn:Read_GPS] Stopped
2025-03-11T17:43:43.064Z,1741715023.064 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2025-03-11T17:43:43.064Z,1741715023.064 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2025-03-11T17:43:43.064Z,1741715023.064 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2025-03-11T17:43:43.065Z,1741715023.065 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2025-03-11T17:43:43.065Z,1741715023.065 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2025-03-11T17:43:43.065Z,1741715023.065 [BuoyancyServo](INFO): Powering down
2025-03-11T17:43:43.078Z,1741715023.078 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2025-03-11T17:43:43.078Z,1741715023.078 [ElevatorServo](INFO): Powering down
2025-03-11T17:43:43.079Z,1741715023.079 [MassServo](DEBUG): Uninitialize Mass Servo.
2025-03-11T17:43:43.079Z,1741715023.079 [MassServo](INFO): Powering down
2025-03-11T17:43:43.080Z,1741715023.080 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2025-03-11T17:43:43.080Z,1741715023.080 [RudderServo](INFO): Powering down
2025-03-11T17:43:43.081Z,1741715023.081 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2025-03-11T17:43:43.081Z,1741715023.081 [ThrusterHE](INFO): Powering down
2025-03-11T17:43:43.082Z,1741715023.082 [SBIT](DEBUG): Uninitialize SBIT Component.
2025-03-11T17:43:43.083Z,1741715023.083 [IBIT](DEBUG): Uninitialize IBIT Component.
2025-03-11T17:43:43.083Z,1741715023.083 [CBIT](DEBUG): Uninitialize CBIT Component.
2025-03-11T17:43:43.083Z,1741715023.083 [CBIT](DEBUG): Powering off loads.
2025-03-11T17:43:43.097Z,1741715023.097 [CBIT](DEBUG): Disabling WDT.
2025-03-11T17:43:43.109Z,1741715023.109 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-03-11T17:43:43.109Z,1741715023.109 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-03-11T17:43:43.110Z,1741715023.110 [controlThread ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.139Z,1741715023.139 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.143Z,1741715023.143 [Onboard ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.150Z,1741715023.150 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.157Z,1741715023.157 [DAT ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.201Z,1741715023.201 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.244Z,1741715023.244 [GFScanner](DEBUG): Uninitialize GFScanner component.
2025-03-11T17:43:43.245Z,1741715023.245 [GFScanner](DEBUG): Opening all GF detection circuits.
2025-03-11T17:43:43.262Z,1741715023.262 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.266Z,1741715023.266 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.334Z,1741715023.334 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2025-03-11T17:43:43.384Z,1741715023.384 [logger ThreadHandler](INFO): Thread cancelled.