2025-04-15T21:15:01.321Z,1744751701.321 [Supervisor](DEBUG): Initializing supervisor. 2025-04-15T21:15:01.326Z,1744751701.326 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-04-15T21:15:01.326Z,1744751701.326 [SyncHandler](INFO): Protected caller Thread ID is 7349 2025-04-15T21:15:01.327Z,1744751701.327 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-04-15T21:15:01.327Z,1744751701.327 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-04-15T21:15:01.328Z,1744751701.328 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7350 2025-04-15T21:15:01.332Z,1744751701.332 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-04-15T21:15:01.350Z,1744751701.350 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-04-15T21:15:01.351Z,1744751701.351 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-04-15T21:15:01.351Z,1744751701.351 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7351 2025-04-15T21:15:01.355Z,1744751701.355 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-04-15T21:15:01.356Z,1744751701.356 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-04-15T21:15:01.357Z,1744751701.357 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7352 2025-04-15T21:15:01.359Z,1744751701.359 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-04-15T21:15:01.360Z,1744751701.360 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-04-15T21:15:01.360Z,1744751701.360 [logger ThreadHandler](INFO): Protected caller Thread ID is 7353 2025-04-15T21:15:01.364Z,1744751701.364 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-04-15T21:15:01.364Z,1744751701.364 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-04-15T21:15:01.366Z,1744751701.366 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-04-15T21:15:01.528Z,1744751701.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-04-15T21:15:01.528Z,1744751701.528 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-04-15T21:15:02.306Z,1744751702.306 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-04-15T21:15:02.306Z,1744751702.306 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-04-15T21:15:02.547Z,1744751702.547 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-04-15T21:15:02.548Z,1744751702.548 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-04-15T21:15:02.638Z,1744751702.638 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-04-15T21:15:02.782Z,1744751702.782 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-04-15T21:15:02.782Z,1744751702.782 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-04-15T21:15:02.876Z,1744751702.876 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-04-15T21:15:02.995Z,1744751702.995 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-04-15T21:15:02.996Z,1744751702.996 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-04-15T21:15:03.405Z,1744751703.405 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-04-15T21:15:03.405Z,1744751703.405 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-04-15T21:15:03.955Z,1744751703.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-04-15T21:15:03.956Z,1744751703.956 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-04-15T21:15:04.186Z,1744751704.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-04-15T21:15:04.187Z,1744751704.187 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-04-15T21:15:04.380Z,1744751704.380 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-04-15T21:15:04.381Z,1744751704.381 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-04-15T21:15:04.938Z,1744751704.938 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-04-15T21:15:04.938Z,1744751704.938 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-04-15T21:15:05.247Z,1744751705.247 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-04-15T21:15:05.247Z,1744751705.247 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-04-15T21:15:05.507Z,1744751705.507 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-04-15T21:15:05.507Z,1744751705.507 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-04-15T21:15:06.090Z,1744751706.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-04-15T21:15:06.090Z,1744751706.090 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-04-15T21:15:06.451Z,1744751706.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-04-15T21:15:06.453Z,1744751706.453 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2025-04-15T21:15:06.454Z,1744751706.454 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2025-04-15T21:15:06.550Z,1744751706.550 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2025-04-15T21:15:06.729Z,1744751706.729 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2025-04-15T21:15:06.847Z,1744751706.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2025-04-15T21:15:06.954Z,1744751706.954 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2025-04-15T21:15:07.073Z,1744751707.073 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2025-04-15T21:15:07.170Z,1744751707.170 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2025-04-15T21:15:07.277Z,1744751707.277 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2025-04-15T21:15:07.401Z,1744751707.401 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2025-04-15T21:15:07.679Z,1744751707.679 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-04-15T21:15:07.680Z,1744751707.680 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2025-04-15T21:15:07.776Z,1744751707.776 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2025-04-15T21:15:07.882Z,1744751707.882 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2025-04-15T21:15:08.038Z,1744751708.038 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2025-04-15T21:15:08.151Z,1744751708.151 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2025-04-15T21:15:08.151Z,1744751708.151 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-04-15T21:15:08.162Z,1744751708.162 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-04-15T21:15:08.301Z,1744751708.301 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-04-15T21:15:08.301Z,1744751708.301 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-04-15T21:15:08.354Z,1744751708.354 [VerticalControl](DEBUG): Construct VerticalControl. 2025-04-15T21:15:08.415Z,1744751708.415 [VerticalControl] Loaded 2025-04-15T21:15:08.415Z,1744751708.415 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-04-15T21:15:08.418Z,1744751708.418 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-04-15T21:15:08.467Z,1744751708.467 [HorizontalControl] Loaded 2025-04-15T21:15:08.467Z,1744751708.467 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-04-15T21:15:08.470Z,1744751708.470 [SpeedControl](DEBUG): Construct SpeedControl. 2025-04-15T21:15:08.473Z,1744751708.473 [SpeedControl] Loaded 2025-04-15T21:15:08.473Z,1744751708.473 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-04-15T21:15:08.476Z,1744751708.476 [LoopControl](DEBUG): Construct LoopControl. 2025-04-15T21:15:08.476Z,1744751708.476 [LoopControl] Loaded 2025-04-15T21:15:08.477Z,1744751708.477 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-04-15T21:15:08.477Z,1744751708.477 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-04-15T21:15:08.478Z,1744751708.478 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-04-15T21:15:08.529Z,1744751708.529 [DepthRateCalculator] Loaded 2025-04-15T21:15:08.529Z,1744751708.529 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-04-15T21:15:08.534Z,1744751708.534 [PitchRateCalculator] Loaded 2025-04-15T21:15:08.535Z,1744751708.535 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-04-15T21:15:08.545Z,1744751708.545 [SpeedCalculator] Loaded 2025-04-15T21:15:08.545Z,1744751708.545 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-04-15T21:15:08.549Z,1744751708.549 [YawRateCalculator] Loaded 2025-04-15T21:15:08.550Z,1744751708.550 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-04-15T21:15:08.568Z,1744751708.568 [ElevatorOffsetCalculator] Loaded 2025-04-15T21:15:08.569Z,1744751708.569 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-04-15T21:15:08.569Z,1744751708.569 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-04-15T21:15:08.570Z,1744751708.570 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-04-15T21:15:08.596Z,1744751708.596 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-04-15T21:15:08.596Z,1744751708.596 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-04-15T21:15:08.655Z,1744751708.655 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-04-15T21:15:08.655Z,1744751708.655 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-04-15T21:15:09.006Z,1744751709.006 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-04-15T21:15:09.007Z,1744751709.007 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-04-15T21:15:09.184Z,1744751709.184 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-04-15T21:15:09.185Z,1744751709.185 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-04-15T21:15:09.674Z,1744751709.674 [AHRS_M2] Loaded 2025-04-15T21:15:09.675Z,1744751709.675 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-04-15T21:15:09.713Z,1744751709.713 [BackseatComponent] Loaded 2025-04-15T21:15:09.713Z,1744751709.713 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-04-15T21:15:09.714Z,1744751709.714 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409E24E0 2025-04-15T21:15:09.715Z,1744751709.715 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7441 2025-04-15T21:15:09.718Z,1744751709.718 [LcmUniversalReporter] Loaded 2025-04-15T21:15:09.718Z,1744751709.718 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-04-15T21:15:10.543Z,1744751710.543 [BPC1] Loaded 2025-04-15T21:15:10.544Z,1744751710.544 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-04-15T21:15:10.641Z,1744751710.641 [DAT] Loaded 2025-04-15T21:15:10.641Z,1744751710.641 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-04-15T21:15:10.642Z,1744751710.642 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A124E0 2025-04-15T21:15:10.643Z,1744751710.643 [DAT ThreadHandler](INFO): Protected caller Thread ID is 7442 2025-04-15T21:15:10.718Z,1744751710.718 [DataOverHttps] Loaded 2025-04-15T21:15:10.718Z,1744751710.718 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-04-15T21:15:10.719Z,1744751710.719 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A424E0 2025-04-15T21:15:10.720Z,1744751710.720 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7443 2025-04-15T21:15:10.743Z,1744751710.743 [Depth_Keller] Loaded 2025-04-15T21:15:10.743Z,1744751710.743 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-04-15T21:15:10.809Z,1744751710.809 [NAL9602] Loaded 2025-04-15T21:15:10.809Z,1744751710.809 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-04-15T21:15:10.838Z,1744751710.838 [Onboard] Loaded 2025-04-15T21:15:10.838Z,1744751710.838 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-04-15T21:15:10.839Z,1744751710.839 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A724E0 2025-04-15T21:15:10.840Z,1744751710.840 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7444 2025-04-15T21:15:10.854Z,1744751710.854 [Power24vConverter] Loaded 2025-04-15T21:15:10.854Z,1744751710.854 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-04-15T21:15:10.870Z,1744751710.870 [Radio_Surface] Loaded 2025-04-15T21:15:10.870Z,1744751710.870 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-04-15T21:15:10.871Z,1744751710.871 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AA24E0 2025-04-15T21:15:10.871Z,1744751710.871 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7445 2025-04-15T21:15:10.994Z,1744751710.994 [RDI_Pathfinder] Loaded 2025-04-15T21:15:10.994Z,1744751710.994 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2025-04-15T21:15:11.010Z,1744751711.010 [Sonardyne_Nano] Loaded 2025-04-15T21:15:11.010Z,1744751711.010 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-04-15T21:15:11.135Z,1744751711.135 [TrnDataBridge] Loaded 2025-04-15T21:15:11.135Z,1744751711.135 [ComponentRegistry](DEBUG): Component "TrnDataBridge" handled in its own thread. 2025-04-15T21:15:11.136Z,1744751711.136 [TrnDataBridge ThreadHandler](DEBUG): Created PCaller Thread at 40AD24E0 2025-04-15T21:15:11.136Z,1744751711.136 [TrnDataBridge ThreadHandler](INFO): Protected caller Thread ID is 7446 2025-04-15T21:15:11.137Z,1744751711.137 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-04-15T21:15:11.137Z,1744751711.137 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-04-15T21:15:11.246Z,1744751711.246 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-04-15T21:15:11.246Z,1744751711.246 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-04-15T21:15:11.260Z,1744751711.260 [NavChart] Loaded 2025-04-15T21:15:11.260Z,1744751711.260 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-04-15T21:15:11.266Z,1744751711.266 [UniversalFixResidualReporter] Loaded 2025-04-15T21:15:11.266Z,1744751711.266 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-04-15T21:15:11.267Z,1744751711.267 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-04-15T21:15:11.267Z,1744751711.267 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-04-15T21:15:11.413Z,1744751711.413 [SBIT](DEBUG): Construct Startup Built In Test. 2025-04-15T21:15:11.422Z,1744751711.422 [SBIT] Loaded 2025-04-15T21:15:11.422Z,1744751711.422 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-04-15T21:15:11.425Z,1744751711.425 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-04-15T21:15:11.438Z,1744751711.438 [IBIT] Loaded 2025-04-15T21:15:11.438Z,1744751711.438 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-04-15T21:15:11.445Z,1744751711.445 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-04-15T21:15:11.551Z,1744751711.551 [CBIT] Loaded 2025-04-15T21:15:11.551Z,1744751711.551 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-04-15T21:15:11.552Z,1744751711.552 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-04-15T21:15:11.552Z,1744751711.552 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-04-15T21:15:11.686Z,1744751711.686 [BuoyancyServo] Loaded 2025-04-15T21:15:11.686Z,1744751711.686 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-04-15T21:15:11.710Z,1744751711.710 [ElevatorServo] Loaded 2025-04-15T21:15:11.710Z,1744751711.710 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-04-15T21:15:11.741Z,1744751711.741 [DockingStepper] Loaded 2025-04-15T21:15:11.741Z,1744751711.741 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2025-04-15T21:15:11.763Z,1744751711.763 [MassServo] Loaded 2025-04-15T21:15:11.764Z,1744751711.764 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-04-15T21:15:11.785Z,1744751711.785 [RudderServo] Loaded 2025-04-15T21:15:11.785Z,1744751711.785 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-04-15T21:15:11.805Z,1744751711.805 [ThrusterServo] Loaded 2025-04-15T21:15:11.805Z,1744751711.805 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2025-04-15T21:15:11.806Z,1744751711.806 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-04-15T21:15:11.806Z,1744751711.806 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-04-15T21:15:11.817Z,1744751711.817 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-04-15T21:15:11.817Z,1744751711.817 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-04-15T21:15:11.995Z,1744751711.995 [CTD_Seabird] Loaded 2025-04-15T21:15:11.995Z,1744751711.995 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-04-15T21:15:11.997Z,1744751711.997 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40C1F4E0 2025-04-15T21:15:11.997Z,1744751711.997 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7447 2025-04-15T21:15:12.020Z,1744751712.020 [PAR_Licor] Loaded 2025-04-15T21:15:12.020Z,1744751712.020 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-04-15T21:15:12.066Z,1744751712.066 [WetLabsBB2FL] Loaded 2025-04-15T21:15:12.066Z,1744751712.066 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-04-15T21:15:12.067Z,1744751712.067 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C4F4E0 2025-04-15T21:15:12.068Z,1744751712.068 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7448 2025-04-15T21:15:12.089Z,1744751712.089 [WetLabsUBAT] Loaded 2025-04-15T21:15:12.089Z,1744751712.089 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2025-04-15T21:15:12.090Z,1744751712.090 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C7F4E0 2025-04-15T21:15:12.091Z,1744751712.091 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 7449 2025-04-15T21:15:12.091Z,1744751712.091 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-04-15T21:15:12.098Z,1744751712.098 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-04-15T21:15:12.101Z,1744751712.101 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-04-15T21:15:12.113Z,1744751712.113 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-04-15T21:15:12.114Z,1744751712.114 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40CAF4E0 2025-04-15T21:15:12.114Z,1744751712.114 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7450 2025-04-15T21:15:12.118Z,1744751712.118 [Supervisor](INFO): Main Thread ID is 830 2025-04-15T21:15:12.119Z,1744751712.119 [Supervisor](DEBUG): Running supervisor. 2025-04-15T21:15:12.119Z,1744751712.119 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7451 2025-04-15T21:15:12.120Z,1744751712.120 [CommandExec](INFO): Initializing the command executive. 2025-04-15T21:15:12.121Z,1744751712.121 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7452 2025-04-15T21:15:12.124Z,1744751712.124 [controlThread ThreadHandler](INFO): Handler Thread ID is 7453 2025-04-15T21:15:12.125Z,1744751712.125 [controlThread](DEBUG): Initializing ControlThread 2025-04-15T21:15:12.126Z,1744751712.126 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-04-15T21:15:12.127Z,1744751712.127 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-04-15T21:15:12.128Z,1744751712.128 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-04-15T21:15:12.128Z,1744751712.128 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-04-15T21:15:12.129Z,1744751712.129 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-04-15T21:15:12.129Z,1744751712.129 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-04-15T21:15:12.129Z,1744751712.129 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-04-15T21:15:12.130Z,1744751712.130 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-04-15T21:15:12.130Z,1744751712.130 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-04-15T21:15:12.134Z,1744751712.134 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-04-15T21:15:12.134Z,1744751712.134 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-04-15T21:15:12.134Z,1744751712.134 [SBIT](INFO): Initialize SBIT Component. 2025-04-15T21:15:12.135Z,1744751712.135 [SBIT](IMPORTANT): git: 2025-01-23 2025-04-15T21:15:12.135Z,1744751712.135 [SBIT](INFO): git hash: e941ed7ca4296489cfe1bf7015177657c0080d4b 2025-04-15T21:15:12.135Z,1744751712.135 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-04-15T21:15:12.137Z,1744751712.137 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-04-15T21:15:12.138Z,1744751712.138 [SBIT](INFO): Beginning SBIT in 101.000000 seconds. 2025-04-15T21:15:12.138Z,1744751712.138 [IBIT](INFO): Initialize IBIT Component. 2025-04-15T21:15:12.139Z,1744751712.139 [CBIT](DEBUG): Initialize CBIT Component. 2025-04-15T21:15:12.140Z,1744751712.140 [logger ThreadHandler](INFO): Handler Thread ID is 7454 2025-04-15T21:15:12.152Z,1744751712.152 [CBIT](DEBUG): Initialized mux pins. 2025-04-15T21:15:12.152Z,1744751712.152 [CBIT](DEBUG): Initializing the watchdog timer. 2025-04-15T21:15:12.161Z,1744751712.161 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7455 2025-04-15T21:15:12.173Z,1744751712.173 [DAT ThreadHandler](INFO): Handler Thread ID is 7456 2025-04-15T21:15:12.173Z,1744751712.173 [DAT](INFO): Powering up 2025-04-15T21:15:12.174Z,1744751712.174 [DAT](DEBUG): Initializing DAT. 2025-04-15T21:15:12.176Z,1744751712.176 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-04-15T21:15:12.177Z,1744751712.177 [CBIT](DEBUG): Initializing heartbeat. 2025-04-15T21:15:12.185Z,1744751712.185 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7457 2025-04-15T21:15:12.187Z,1744751712.187 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-04-15T21:15:12.205Z,1744751712.205 [Onboard ThreadHandler](INFO): Handler Thread ID is 7458 2025-04-15T21:15:12.222Z,1744751712.222 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7459 2025-04-15T21:15:12.241Z,1744751712.241 [TrnDataBridge ThreadHandler](INFO): Handler Thread ID is 7460 2025-04-15T21:15:12.241Z,1744751712.241 [TrnDataBridge](INFO): Start 2025-04-15T21:15:12.241Z,1744751712.241 [TrnDataBridge](IMPORTANT): LCM Instance1 2025-04-15T21:15:12.249Z,1744751712.249 [CBIT](DEBUG): Deactivating GF circuits. 2025-04-15T21:15:12.249Z,1744751712.249 [CBIT](DEBUG): Deactivating emergency mode. 2025-04-15T21:15:12.273Z,1744751712.273 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7462 2025-04-15T21:15:12.274Z,1744751712.274 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-04-15T21:15:12.281Z,1744751712.281 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7464 2025-04-15T21:15:12.285Z,1744751712.285 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 7466 2025-04-15T21:15:12.287Z,1744751712.287 [WetLabsBB2FL](INFO): Powering up 2025-04-15T21:15:12.288Z,1744751712.288 [CBIT](DEBUG): Backplane powered. 2025-04-15T21:15:12.293Z,1744751712.293 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-04-15T21:15:12.294Z,1744751712.294 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl 2025-04-15T21:15:12.294Z,1744751712.294 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl 2025-04-15T21:15:12.295Z,1744751712.295 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl 2025-04-15T21:15:12.302Z,1744751712.302 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into: 2025-04-15T21:15:12.302Z,1744751712.302 [MissionManager](ERROR): Top node has no child nodes: Mission 2025-04-15T21:15:12.302Z,1744751712.302 [MissionManager](ERROR): Could not load startup mission. 2025-04-15T21:15:12.303Z,1744751712.303 [MissionManager](INFO): Loading Mission from file: Missions/Engineering/DefaultTankUndock.tl 2025-04-15T21:15:12.303Z,1744751712.303 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Engineering/DefaultTankUndock.tl 2025-04-15T21:15:12.305Z,1744751712.305 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Engineering/DefaultTankUndock.tl 2025-04-15T21:15:12.313Z,1744751712.313 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7468 2025-04-15T21:15:12.316Z,1744751712.316 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-04-15T21:15:12.316Z,1744751712.316 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-04-15T21:15:12.316Z,1744751712.316 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-04-15T21:15:12.316Z,1744751712.316 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-04-15T21:15:12.316Z,1744751712.316 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-04-15T21:15:12.317Z,1744751712.317 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-04-15T21:15:12.317Z,1744751712.317 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-04-15T21:15:12.317Z,1744751712.317 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-04-15T21:15:12.345Z,1744751712.345 [WetLabsUBAT](INFO): Powering up 2025-04-15T21:15:12.629Z,1744751712.629 [Radio_Surface](INFO): Powering up 2025-04-15T21:15:12.637Z,1744751712.637 [MissionManager](DEBUG): TethyslAPI: Missions/Engineering/DefaultTankUndock.tl translated into: 0 13 dock arm 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-04-15T21:15:12.655Z,1744751712.655 [MissionManager](INFO): DefineArg DefaultTankUndock.ElapsedSinceDefaultStarted = 0.000000 min 2025-04-15T21:15:12.656Z,1744751712.656 [DefaultTankUndock:A.Wait](DEBUG): Construct Wait. 2025-04-15T21:15:12.678Z,1744751712.678 [DefaultTankUndock:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-15T21:15:12.718Z,1744751712.718 [DefaultTankUndock:C.Execute](DEBUG): Construct Execute. 2025-04-15T21:15:12.723Z,1744751712.723 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-04-15T21:15:12.746Z,1744751712.746 [DefaultTankUndock:F.Execute](DEBUG): Construct Execute. 2025-04-15T21:15:12.749Z,1744751712.749 [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 DefaultTankUndock { 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 } behavior Guidance:Execute { run in sequence set command = "dock arm" } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H 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-04-15T21:15:12.764Z,1744751712.764 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2025-04-15T21:15:12.781Z,1744751712.781 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-04-15T21:15:12.839Z,1744751712.839 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2025-04-15T21:15:12.840Z,1744751712.840 [Power24vConverter](INFO): Powering up. 2025-04-15T21:15:12.841Z,1744751712.841 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2025-04-15T21:15:12.841Z,1744751712.841 [Sonardyne_Nano](INFO): Initializing. 2025-04-15T21:15:12.862Z,1744751712.862 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-04-15T21:15:12.886Z,1744751712.886 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-04-15T21:15:12.886Z,1744751712.886 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-04-15T21:15:12.887Z,1744751712.887 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-04-15T21:15:12.893Z,1744751712.893 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-04-15T21:15:12.893Z,1744751712.893 [DockingStepper](INFO): Start 2025-04-15T21:15:12.894Z,1744751712.894 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-04-15T21:15:12.894Z,1744751712.894 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-04-15T21:15:12.895Z,1744751712.895 [MassServo](DEBUG): Initializing EZServoServo. 2025-04-15T21:15:12.905Z,1744751712.905 [MassServo](DEBUG): Initializing MassServo. 2025-04-15T21:15:12.905Z,1744751712.905 [RudderServo](DEBUG): Initializing EZServoServo. 2025-04-15T21:15:12.913Z,1744751712.913 [RudderServo](DEBUG): Initializing RudderServo. 2025-04-15T21:15:12.913Z,1744751712.913 [ThrusterServo](DEBUG): Initializing EZServoServo. 2025-04-15T21:15:12.921Z,1744751712.921 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2025-04-15T21:15:13.233Z,1744751713.233 [DockingStepper](INFO): Starting 2025-04-15T21:15:13.600Z,1744751713.600 [DockingStepper](INFO): Starting 2025-04-15T21:15:14.125Z,1744751714.125 [DockingStepper](INFO): Starting 2025-04-15T21:15:14.173Z,1744751714.173 [DockingStepper](INFO): Init string: /1z16367aE13561N3m50 2025-04-15T21:15:14.454Z,1744751714.454 [DockingStepper](INFO): Starting 2025-04-15T21:15:14.799Z,1744751714.799 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-04-15T21:15:14.864Z,1744751714.864 [DockingStepper](INFO): Starting 2025-04-15T21:15:14.896Z,1744751714.896 [WetLabsBB2FL](INFO): Powering down 2025-04-15T21:15:15.222Z,1744751715.222 [DockingStepper](INFO): Starting 2025-04-15T21:15:15.685Z,1744751715.685 [DockingStepper](INFO): Starting 2025-04-15T21:15:15.709Z,1744751715.709 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-04-15T21:15:16.166Z,1744751716.166 [DockingStepper](INFO): Starting 2025-04-15T21:15:16.453Z,1744751716.453 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2025-04-15T21:15:16.901Z,1744751716.901 [DockingStepper](INFO): Pause 2025-04-15T21:15:17.881Z,1744751717.881 [Radio_Surface](INFO): Checking local IP, expecting subnet 10.89.10 2025-04-15T21:15:17.882Z,1744751717.882 [Radio_Surface](INFO): Found local IP address 10.89.10.2 for eth0 2025-04-15T21:15:21.596Z,1744751721.596 [WetLabsUBAT](INFO): Powering down 2025-04-15T21:15:25.279Z,1744751725.279 [DAT](INFO): DAT read: 2025-04-15T21:15:25.283Z,1744751725.283 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-04-15T21:15:34.351Z,1744751734.351 [DAT](INFO): DAT read: MF Frequency Band 2025-04-15T21:15:34.353Z,1744751734.353 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2025-04-15T21:15:34.354Z,1744751734.354 [DAT](INFO): DAT read: Apr 15 2025 21:15:20 2025-04-15T21:15:35.358Z,1744751735.358 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-04-15T21:15:35.359Z,1744751735.359 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2025-04-15T21:15:35.359Z,1744751735.359 [DAT](INFO): commRate: 600 2025-04-15T21:15:37.425Z,1744751737.425 [DAT](INFO): entering command mode 2025-04-15T21:15:37.625Z,1744751737.625 [DAT](INFO): DAT read: 2025-04-15T21:15:37.626Z,1744751737.626 [DAT](INFO): DAT read: user:1> 2025-04-15T21:15:37.626Z,1744751737.626 [DAT](INFO): setting verbose to 3 2025-04-15T21:15:37.877Z,1744751737.877 [DAT](INFO): DAT read: user:1> 2025-04-15T21:15:37.878Z,1744751737.878 [DAT](INFO): DAT read: Verbose | 3 2025-04-15T21:15:37.878Z,1744751737.878 [DAT](INFO): set verbose to 3 2025-04-15T21:15:37.879Z,1744751737.879 [DAT](INFO): setting DatVerbose to 27440 2025-04-15T21:15:38.129Z,1744751738.129 [DAT](INFO): DAT read: user:2> 2025-04-15T21:15:38.130Z,1744751738.130 [DAT](INFO): DAT read: DatVerbose | 27440 2025-04-15T21:15:38.130Z,1744751738.130 [DAT](INFO): set DatVerbose to 27440 2025-04-15T21:15:38.131Z,1744751738.131 [DAT](INFO): setting transmit power to 8 2025-04-15T21:15:38.382Z,1744751738.382 [DAT](INFO): DAT read: user:3> 2025-04-15T21:15:38.383Z,1744751738.383 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-04-15T21:15:38.383Z,1744751738.383 [DAT](INFO): set transmit power to 8 2025-04-15T21:15:38.384Z,1744751738.384 [DAT](INFO): setting local address to 10 2025-04-15T21:15:38.633Z,1744751738.633 [DAT](INFO): DAT read: user:4> 2025-04-15T21:15:38.634Z,1744751738.634 [DAT](INFO): DAT read: LocalAddr | 10 2025-04-15T21:15:38.634Z,1744751738.634 [DAT](INFO): set local address to 10 2025-04-15T21:15:38.635Z,1744751738.635 [DAT](INFO): Setting time to: 21:15:38 And date to:4/15/2025 2025-04-15T21:15:38.885Z,1744751738.885 [DAT](INFO): DAT read: user:5> 2025-04-15T21:15:38.886Z,1744751738.886 [DAT](INFO): DAT read: Tue Apr 15, 2025 21:15:38 2025-04-15T21:15:38.886Z,1744751738.886 [DAT](INFO): Local DAT time set to Tue Apr 15, 2025 21:15:38 2025-04-15T21:15:41.162Z,1744751741.162 [NAL9602](INFO): Powering up NAL9602 2025-04-15T21:15:43.309Z,1744751743.309 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:15:52.062Z,1744751752.062 [NAL9602](INFO): NAL9602 initialized 2025-04-15T21:16:14.433Z,1744751774.433 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:16:27.609Z,1744751787.609 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-04-15T21:16:42.961Z,1744751802.961 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-04-15T21:16:45.565Z,1744751805.565 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:16:53.935Z,1744751813.935 [SBIT](IMPORTANT): Beginning Startup BIT 2025-04-15T21:16:53.940Z,1744751813.940 [CBIT](IMPORTANT): Beginning ground fault scan 2025-04-15T21:17:04.869Z,1744751824.869 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.035544 CHAN A1 (24V): 0.038103 CHAN A2 (12V): 0.026668 CHAN A3 (5V): 0.011938 CHAN B0 (3.3V): 0.009974 CHAN B1 (3.15aV): 0.008227 CHAN B2 (3.15bV): 0.009244 CHAN B3 (GND): 0.002843 OPEN: 0.008461 Full Scale: +/- 1 mA 2025-04-15T21:17:16.689Z,1744751836.689 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:17:47.813Z,1744751867.813 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:17:48.080Z,1744751868.080 [SBIT](IMPORTANT): SBIT PASSED 2025-04-15T21:17:48.081Z,1744751868.081 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-04-15T21:17:48.081Z,1744751868.081 [SBIT](IMPORTANT): CBIT.gf24Offset=173 microampere; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): DAT.convertPhaseDataToDirection=0 bool; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): DockingStepper.closedValue=16450 count; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): DockingStepper.slideValue=10700 count; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=20 ampere_hour; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=12 volt; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): RudderServo.offsetAngle=0.2 degree; 2025-04-15T21:17:48.082Z,1744751868.082 [SBIT](IMPORTANT): TrnDataBridge.loadAtStartup=1 bool; 2025-04-15T21:17:48.083Z,1744751868.083 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=460.577328 cubic_centimeter; 2025-04-15T21:17:48.083Z,1744751868.083 [SBIT](IMPORTANT): VerticalControl.massDefault=20.377216 millimeter; 2025-04-15T21:17:48.503Z,1744751868.503 [MissionManager](IMPORTANT): Started mission DefaultTankUndock 2025-04-15T21:17:48.503Z,1744751868.503 [DefaultTankUndock] Running Loop=1 2025-04-15T21:17:48.503Z,1744751868.503 [DefaultTankUndock](DEBUG): Aggregate::initialize DefaultTankUndock 2025-04-15T21:17:48.503Z,1744751868.503 [DefaultTankUndock:B.GoToSurface] Running Loop=1 2025-04-15T21:17:48.503Z,1744751868.503 [DefaultTankUndock:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-15T21:17:48.504Z,1744751868.504 [DefaultTankUndock:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-15T21:17:48.504Z,1744751868.504 [DefaultTankUndock:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-15T21:17:48.505Z,1744751868.505 [DefaultTankUndock:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-15T21:17:48.505Z,1744751868.505 [DefaultTankUndock:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-15T21:17:48.505Z,1744751868.505 [DefaultTankUndock:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-15T21:17:48.506Z,1744751868.506 [DefaultTankUndock:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-15T21:17:48.506Z,1744751868.506 [DefaultTankUndock:A.Wait] Running Loop=1 2025-04-15T21:17:48.506Z,1744751868.506 [DefaultTankUndock:A.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:18:01.835Z,1744751881.835 [DefaultTankUndock:A.Wait](INFO): Done Waiting. 2025-04-15T21:18:01.836Z,1744751881.836 [DefaultTankUndock:A.Wait] Stopped 2025-04-15T21:18:01.836Z,1744751881.836 [DefaultTankUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:18:02.215Z,1744751882.215 [DefaultTankUndock:C.Execute] Running Loop=1 2025-04-15T21:18:02.665Z,1744751882.665 [DefaultTankUndock:C.Execute](INFO): Executing command dock arm 2025-04-15T21:18:02.666Z,1744751882.666 [DefaultTankUndock:C.Execute] Stopped 2025-04-15T21:18:02.666Z,1744751882.666 [DefaultTankUndock:CheckIn] Running Loop=1 2025-04-15T21:18:02.666Z,1744751882.666 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::initialize DefaultTankUndock:CheckIn 2025-04-15T21:18:02.666Z,1744751882.666 [DefaultTankUndock:CheckIn:Read_GPS] Running Loop=1 2025-04-15T21:18:02.766Z,1744751882.766 [CommandExec](IMPORTANT): got command docking arm 2025-04-15T21:18:02.766Z,1744751882.766 [CommandExec](IMPORTANT): Switching docking module to ARM. 2025-04-15T21:18:03.039Z,1744751883.039 [DefaultTankUndock:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-04-15T21:18:03.433Z,1744751883.433 [DockingStepper](INFO): Resume 2025-04-15T21:18:03.861Z,1744751883.861 [DockingStepper](INFO): Resuming 2025-04-15T21:18:04.240Z,1744751884.240 [DockingStepper](INFO): Start 2025-04-15T21:18:04.241Z,1744751884.241 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-04-15T21:18:04.241Z,1744751884.241 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-04-15T21:18:04.689Z,1744751884.689 [DockingStepper](INFO): Starting 2025-04-15T21:18:05.049Z,1744751885.049 [DockingStepper](INFO): Starting 2025-04-15T21:18:05.532Z,1744751885.532 [DockingStepper](INFO): Starting 2025-04-15T21:18:05.590Z,1744751885.590 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2025-04-15T21:18:05.910Z,1744751885.910 [DockingStepper](INFO): Starting 2025-04-15T21:18:06.272Z,1744751886.272 [DockingStepper](INFO): Starting 2025-04-15T21:18:06.722Z,1744751886.722 [DockingStepper](INFO): Starting 2025-04-15T21:18:07.075Z,1744751887.075 [DockingStepper](INFO): Starting 2025-04-15T21:18:07.126Z,1744751887.126 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-04-15T21:18:07.471Z,1744751887.471 [DockingStepper](INFO): Starting 2025-04-15T21:18:07.912Z,1744751887.912 [DockingStepper](INFO): Changing to mode: 2 2025-04-15T21:18:07.912Z,1744751887.912 [DockingStepper](INFO): Armed mode. 2025-04-15T21:18:07.980Z,1744751887.980 [DockingStepper](INFO): Commanding negative:54593 2025-04-15T21:18:12.329Z,1744751892.329 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-04-15T21:18:12.329Z,1744751892.329 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-04-15T21:18:12.404Z,1744751892.404 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-04-15T21:18:12.834Z,1744751892.834 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-04-15T21:18:12.834Z,1744751892.834 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-04-15T21:18:18.945Z,1744751898.945 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:18:50.069Z,1744751930.069 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:18:57.874Z,1744751937.874 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004329 2025-04-15T21:18:58.873Z,1744751938.873 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:19:08.473Z,1744751948.473 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:19:17.345Z,1744751957.345 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:19:19.374Z,1744751959.374 [CommandExec](IMPORTANT): got command strobe off 2025-04-15T21:19:19.374Z,1744751959.374 [CommandExec](IMPORTANT): Deactivating strobe 2025-04-15T21:19:25.054Z,1744751965.054 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:19:26.253Z,1744751966.253 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:19:31.131Z,1744751971.131 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,25041513204186,35.0, +18.9, 06, 0 2025-04-15T21:19:34.978Z,1744751974.978 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:19:36.770Z,1744751976.770 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:19:43.729Z,1744751983.729 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:19:48.082Z,1744751988.082 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:19:52.537Z,1744751992.537 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:19:59.394Z,1744751999.394 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:20:01.253Z,1744752001.253 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:20:10.319Z,1744752010.319 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:20:12.029Z,1744752012.029 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:20:15.294Z,1744752015.294 [CommandExec](IMPORTANT): got command docking standby 2025-04-15T21:20:15.294Z,1744752015.294 [CommandExec](IMPORTANT): Switching docking module to STANDBY. 2025-04-15T21:20:15.727Z,1744752015.727 [DockingStepper](INFO): Changing to mode: 1 2025-04-15T21:20:15.727Z,1744752015.727 [DockingStepper](INFO): Standby mode. 2025-04-15T21:20:15.797Z,1744752015.797 [DockingStepper](INFO): Commanding positive:54389 2025-04-15T21:20:21.241Z,1744752021.241 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:20:24.521Z,1744752024.521 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:20:32.958Z,1744752032.958 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:20:33.369Z,1744752033.369 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:20:43.509Z,1744752043.509 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:20:44.269Z,1744752044.269 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:20:51.482Z,1744752051.482 [CommandExec](IMPORTANT): got command configSet VerticalControl.buoyancyNeutral 200 cubic_centimeter persist 2025-04-15T21:20:52.525Z,1744752052.525 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:20:55.985Z,1744752055.985 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:20:55.994Z,1744752055.994 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-04-15T21:20:57.212Z,1744752057.212 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212056.00,A,3648.16228,N,12147.28475,W,0.019,0.00,150425,,,D*7F 2025-04-15T21:20:57.223Z,1744752057.223 [NAL9602](INFO): GPS fix at 20250415T212056: (36.802705, -121.788079) 2025-04-15T21:20:57.305Z,1744752057.305 [DefaultTankUndock:CheckIn:Read_GPS] Stopped 2025-04-15T21:20:57.306Z,1744752057.306 [DefaultTankUndock:CheckIn:Read_Iridium] Running Loop=1 2025-04-15T21:20:57.657Z,1744752057.657 [DefaultTankUndock:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-15T21:21:01.820Z,1744752061.820 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250415T205421/Courier0003.lzma 2025-04-15T21:21:02.830Z,1744752062.830 [DataOverHttps](INFO): Moved sent file to Logs/20250415T205421/Courier0003.lzma.bak 2025-04-15T21:21:02.830Z,1744752062.830 [DataOverHttps](INFO): SBD MOMSN=24667974 2025-04-15T21:21:06.885Z,1744752066.885 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:21:18.238Z,1744752078.238 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:21:25.702Z,1744752085.702 [DataOverHttps](INFO): Sending 391 bytes from file Logs/20250415T210417/Courier0000.lzma 2025-04-15T21:21:26.702Z,1744752086.702 [DataOverHttps](INFO): Moved sent file to Logs/20250415T210417/Courier0000.lzma.bak 2025-04-15T21:21:26.702Z,1744752086.702 [DataOverHttps](INFO): SBD MOMSN=24667976 2025-04-15T21:21:29.495Z,1744752089.495 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:21:29.517Z,1744752089.517 [NAL9602](INFO): Not Powering down - fast GPS 2025-04-15T21:21:40.403Z,1744752100.403 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2025-04-15T21:21:46.208Z,1744752106.208 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20250415T211501/Courier0000.lzma 2025-04-15T21:21:47.210Z,1744752107.210 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0000.lzma.bak 2025-04-15T21:21:47.211Z,1744752107.211 [DataOverHttps](IMPORTANT): SBD MOMSN=24667982, MTMSN=20250415T212146 2025-04-15T21:22:01.268Z,1744752121.268 [DataOverHttps](INFO): Received command: schedule resume 2025-04-15T21:22:01.362Z,1744752121.362 [CommandExec](IMPORTANT): got command schedule resume 2025-04-15T21:22:01.408Z,1744752121.408 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-04-15T21:22:01.462Z,1744752121.462 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 4. 2025-04-15T21:22:01.469Z,1744752121.469 [BPC1](INFO): Received data from all battery sticks. 2025-04-15T21:22:02.594Z,1744752122.594 [DataOverHttps](IMPORTANT): SBD MTMSN=20250415T212201 2025-04-15T21:22:13.981Z,1744752133.981 [DataOverHttps](INFO): Sending 451 bytes from file Logs/20250415T205421/Express0004.lzma 2025-04-15T21:22:13.984Z,1744752133.984 [DataOverHttps](INFO): Received command: sched asap "load Engineering/sink.tl;set sink.SinkDuration 30 min;set sink.Depth 1 m;set sink.DepthDeadband .25 m;set sink.SurfaceThreshold 0.1 m;set sink.MinAltitude 0.01 m;set sink.MaxDepth 2 m;set sink.MinOffshore 0.00001 km" 4tvcb 1 2 2025-04-15T21:22:14.095Z,1744752134.095 [CommandExec](IMPORTANT): got command schedule asap "load Engineering/sink.tl;set sink.SinkDuration 30 min;set sink.Depth 1 m;set sink.DepthDeadband .25 m;set sink.SurfaceThreshold 0.1 m;set sink.MinAltitude 0.01 m;set sink.MaxDepth 2 m;set sink.MinOffshore 0.00001 km" 4tvcb 1 2.000000 2025-04-15T21:22:14.095Z,1744752134.095 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=4tvcb 2025-04-15T21:22:14.112Z,1744752134.112 [CommandExec](IMPORTANT): Scheduled #1 (#1 of 2 with id='4tvcb'): "load Engineering/sink.tl;set sink.SinkDuration 30 min;set sink.Depth 1 m;set sink.DepthDeadband .25 m;set sink.SurfaceThreshold 0.1 m;set sink.MinAltitude 0.01 m;set sink.MaxDepth 2 m;set sink.MinOffshore 0.00001 km", ASAP 2025-04-15T21:22:15.967Z,1744752135.967 [DataOverHttps](INFO): Moved sent file to Logs/20250415T205421/Express0004.lzma.bak 2025-04-15T21:22:15.968Z,1744752135.968 [DataOverHttps](IMPORTANT): SBD MOMSN=24667988, MTMSN=20250415T212214 2025-04-15T21:22:33.065Z,1744752153.065 [DataOverHttps](INFO): Received command: sched asap "set sink.SkipComms 1 bool;run" 4tvcb 2 2 2025-04-15T21:22:33.128Z,1744752153.128 [CommandExec](IMPORTANT): got command schedule asap "set sink.SkipComms 1 bool;run" 4tvcb 2 2.000000 2025-04-15T21:22:33.129Z,1744752153.129 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=4tvcb 2025-04-15T21:22:33.130Z,1744752153.130 [CommandExec](IMPORTANT): Scheduled #2 (#2 of 2 with id='4tvcb'): "set sink.SkipComms 1 bool;run", ASAP 2025-04-15T21:22:33.252Z,1744752153.252 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/sink.tl 2025-04-15T21:22:33.252Z,1744752153.252 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/sink.tl 2025-04-15T21:22:33.252Z,1744752153.252 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/sink.tl 2025-04-15T21:22:33.254Z,1744752153.254 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/sink.tl 2025-04-15T21:22:41.440Z,1744752161.440 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/sink.tl translated into: 2 20 20 1 2.5 20 10 45 10 0.5 25 98 5 30 2 2025-04-15T21:22:41.454Z,1744752161.454 [MissionManager](INFO): DefineArg sink.SinkDuration = 2.000000 h 2025-04-15T21:22:41.461Z,1744752161.461 [MissionManager](INFO): DefineArg sink.WaitToFloat = 20.000000 min 2025-04-15T21:22:41.464Z,1744752161.464 [MissionManager](INFO): DefineArg sink.Depth = 20.000000 m 2025-04-15T21:22:41.503Z,1744752161.503 [MissionManager](INFO): DefineArg sink.DepthDeadband = 1.000000 m 2025-04-15T21:22:41.510Z,1744752161.510 [MissionManager](INFO): DefineArg sink.SurfaceThreshold = 2.500000 m 2025-04-15T21:22:41.529Z,1744752161.529 [MissionManager](INFO): DefineArg sink.TargetDepthTimeout = 20.000000 min 2025-04-15T21:22:41.532Z,1744752161.532 [MissionManager](INFO): DefineArg sink.DoBallastAndTrim = 0 bool 2025-04-15T21:22:41.543Z,1744752161.543 [MissionManager](INFO): DefineArg sink.BTSettleTime = 10.000000 min 2025-04-15T21:22:41.593Z,1744752161.593 [MissionManager](INFO): DefineArg sink.EstimationTimeout = 45.000000 min 2025-04-15T21:22:41.596Z,1744752161.596 [MissionManager](INFO): DefineArg sink.MinEstimationTime = 10.000000 min 2025-04-15T21:22:41.607Z,1744752161.607 [MissionManager](INFO): DefineArg sink.MassEstimationErrorBound = 0.500000 mm 2025-04-15T21:22:41.634Z,1744752161.634 [MissionManager](INFO): DefineArg sink.BuoyEstimationErrorBound = 25.000000 cc 2025-04-15T21:22:41.662Z,1744752161.662 [MissionManager](INFO): DefineArg sink.EstimationConfidence = 98.000000 % 2025-04-15T21:22:41.671Z,1744752161.671 [MissionManager](INFO): DefineArg sink.MinAltitude = 5.000000 m 2025-04-15T21:22:41.704Z,1744752161.704 [MissionManager](INFO): DefineArg sink.MaxDepth = 30.000000 m 2025-04-15T21:22:41.763Z,1744752161.763 [MissionManager](INFO): DefineArg sink.MinOffshore = 2.000000 km 2025-04-15T21:22:41.774Z,1744752161.774 [MissionManager](INFO): DefineArg sink.SkipComms = 0 bool 2025-04-15T21:22:41.794Z,1744752161.794 [MissionManager](INFO): DefineOutput sink.MissionTimeout = 2.000000 h 2025-04-15T21:22:41.802Z,1744752161.802 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl 2025-04-15T21:22:41.802Z,1744752161.802 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl 2025-04-15T21:22:41.809Z,1744752161.809 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl 2025-04-15T21:22:46.159Z,1744752166.159 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into: NaN 3 100 80 20 5 NaN NaN 2.0 NaN NaN 5 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 _.planktivore_LM_AvgRois _.planktivore_HM_AvgRois _.planktivore_diatoms _.planktivore_dinoflagellates Triggered. PeakChl values on consecutive yo-yo profiles fall in [ ] (NaN bound is ignored). 2025-04-15T21:22:46.200Z,1744752166.200 [MissionManager](INFO): DefineArg sink:Science.PeakDetectChlActive = 0 bool 2025-04-15T21:22:46.203Z,1744752166.203 [MissionManager](INFO): DefineArg sink:Science.TimeWindowPeakReport = nan min 2025-04-15T21:22:46.205Z,1744752166.205 [MissionManager](INFO): DefineArg sink:Science.HighestChlPeakReportActive = 0 bool 2025-04-15T21:22:46.208Z,1744752166.208 [MissionManager](INFO): DefineArg sink:Science.HighestSaltPeakReportActive = 0 bool 2025-04-15T21:22:46.211Z,1744752166.211 [MissionManager](INFO): DefineArg sink:Science.HighestOilPeakReportActive = 0 bool 2025-04-15T21:22:46.213Z,1744752166.213 [MissionManager](INFO): DefineArg sink:Science.PatchTracking = 0 bool 2025-04-15T21:22:46.216Z,1744752166.216 [MissionManager](INFO): DefineArg sink:Science.FilterWidthHorizontal = 3.000000 count 2025-04-15T21:22:46.219Z,1744752166.219 [MissionManager](INFO): DefineArg sink:Science.NumProfilesSlidingwindow = 100.000000 count 2025-04-15T21:22:46.222Z,1744752166.222 [MissionManager](INFO): DefineArg sink:Science.OffPeakFractionHorizontal = 80.000000 % 2025-04-15T21:22:46.225Z,1744752166.225 [MissionManager](INFO): DefineArg sink:Science.PeakDetectNO3Active = 0 bool 2025-04-15T21:22:46.228Z,1744752166.228 [MissionManager](INFO): DefineArg sink:Science.PeakDetectOilActive = 0 bool 2025-04-15T21:22:46.230Z,1744752166.230 [MissionManager](INFO): DefineArg sink:Science.PeakDetectFDOMActive = 0 bool 2025-04-15T21:22:46.277Z,1744752166.277 [MissionManager](INFO): DefineArg sink:Science.PeakDetectSalinityActive = 0 bool 2025-04-15T21:22:46.280Z,1744752166.280 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool 2025-04-15T21:22:46.287Z,1744752166.287 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool 2025-04-15T21:22:46.293Z,1744752166.293 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool 2025-04-15T21:22:46.296Z,1744752166.296 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool 2025-04-15T21:22:46.314Z,1744752166.314 [MissionManager](INFO): DefineArg sink:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2025-04-15T21:22:46.334Z,1744752166.334 [MissionManager](INFO): DefineArg sink:Science.EnabledAanderaaO2 = 0 bool 2025-04-15T21:22:46.342Z,1744752166.342 [MissionManager](INFO): DefineArg sink:Science.EnabledNeilBrown = 0 bool 2025-04-15T21:22:46.346Z,1744752166.346 [MissionManager](INFO): DefineArg sink:Science.EnabledSeabird = 1 bool 2025-04-15T21:22:46.366Z,1744752166.366 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsBB2FL = 1 bool 2025-04-15T21:22:46.386Z,1744752166.386 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2025-04-15T21:22:46.421Z,1744752166.421 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsUBAT = 1 bool 2025-04-15T21:22:46.424Z,1744752166.424 [MissionManager](INFO): DefineArg sink:Science.LowPassWindowLength = 20.000000 count 2025-04-15T21:22:46.443Z,1744752166.443 [MissionManager](INFO): DefineArg sink:Science.MedianFilterLen = 5.000000 count 2025-04-15T21:22:46.450Z,1744752166.450 [MissionManager](INFO): DefineArg sink:Science.PeakShallowBound = nan m 2025-04-15T21:22:46.469Z,1744752166.469 [MissionManager](INFO): DefineArg sink:Science.PeakDeepBound = nan m 2025-04-15T21:22:46.472Z,1744752166.472 [MissionManager](INFO): DefineArg sink:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2025-04-15T21:22:46.483Z,1744752166.483 [MissionManager](INFO): DefineArg sink:Science.ChlThreshTriggerActive = 0 bool 2025-04-15T21:22:46.491Z,1744752166.491 [MissionManager](INFO): DefineArg sink:Science.ChlLowerThresh = nan ug/l 2025-04-15T21:22:46.498Z,1744752166.498 [MissionManager](INFO): DefineArg sink:Science.ChlUpperThresh = nan ug/l 2025-04-15T21:22:46.525Z,1744752166.525 [MissionManager](INFO): DefineArg sink:Science.NumProfilesThresh = 5.000000 count 2025-04-15T21:22:46.528Z,1744752166.528 [MissionManager](INFO): DefineOutput sink:Science.PeakChl = nan ug/l 2025-04-15T21:22:46.551Z,1744752166.551 [MissionManager](INFO): DefineOutput sink:Science.PeakChlDepth = nan m 2025-04-15T21:22:46.554Z,1744752166.554 [MissionManager](INFO): DefineOutput sink:Science.PeakChlTemperature = nan degC 2025-04-15T21:22:46.566Z,1744752166.566 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLatitude = nan arcdeg 2025-04-15T21:22:46.577Z,1744752166.577 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLongitude = nan arcdeg 2025-04-15T21:22:46.593Z,1744752166.593 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3 = nan umol/l 2025-04-15T21:22:46.596Z,1744752166.596 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Depth = nan m 2025-04-15T21:22:46.603Z,1744752166.603 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Latitude = nan arcdeg 2025-04-15T21:22:46.614Z,1744752166.614 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Longitude = nan arcdeg 2025-04-15T21:22:46.619Z,1744752166.619 [MissionManager](INFO): DefineOutput sink:Science.PeakOil = nan kg/m3 2025-04-15T21:22:46.631Z,1744752166.631 [MissionManager](INFO): DefineOutput sink:Science.PeakOilDepth = nan m 2025-04-15T21:22:46.643Z,1744752166.643 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLatitude = nan arcdeg 2025-04-15T21:22:46.661Z,1744752166.661 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250415T211501/Courier0004.lzma 2025-04-15T21:22:46.670Z,1744752166.670 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLongitude = nan arcdeg 2025-04-15T21:22:46.674Z,1744752166.674 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOM = nan ppb 2025-04-15T21:22:46.693Z,1744752166.693 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMDepth = nan m 2025-04-15T21:22:46.696Z,1744752166.696 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMTemperature = nan degC 2025-04-15T21:22:46.710Z,1744752166.710 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLatitude = nan arcdeg 2025-04-15T21:22:46.723Z,1744752166.723 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLongitude = nan arcdeg 2025-04-15T21:22:46.743Z,1744752166.743 [MissionManager](INFO): DefineOutput sink:Science.PeakSalt = nan psu 2025-04-15T21:22:46.752Z,1744752166.752 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltDepth = nan m 2025-04-15T21:22:46.772Z,1744752166.772 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltTemperature = nan degC 2025-04-15T21:22:46.794Z,1744752166.794 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLatitude = nan arcdeg 2025-04-15T21:22:46.834Z,1744752166.834 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLongitude = nan arcdeg 2025-04-15T21:22:46.858Z,1744752166.858 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROI = nan count/s 2025-04-15T21:22:46.865Z,1744752166.865 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROIDepth = nan m 2025-04-15T21:22:46.868Z,1744752166.868 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROITemperature = nan degC 2025-04-15T21:22:46.880Z,1744752166.880 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg 2025-04-15T21:22:46.899Z,1744752166.899 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg 2025-04-15T21:22:46.907Z,1744752166.907 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROI = nan count/s 2025-04-15T21:22:46.930Z,1744752166.930 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROIDepth = nan m 2025-04-15T21:22:46.939Z,1744752166.939 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROITemperature = nan degC 2025-04-15T21:22:46.954Z,1744752166.954 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg 2025-04-15T21:22:46.968Z,1744752166.968 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg 2025-04-15T21:22:46.971Z,1744752166.971 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatoms = nan count/ml 2025-04-15T21:22:46.975Z,1744752166.975 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsDepth = nan m 2025-04-15T21:22:47.004Z,1744752167.004 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsTemperature = nan degC 2025-04-15T21:22:47.011Z,1744752167.011 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg 2025-04-15T21:22:47.026Z,1744752167.026 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg 2025-04-15T21:22:47.050Z,1744752167.050 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellates = nan count/ml 2025-04-15T21:22:47.066Z,1744752167.066 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesDepth = nan m 2025-04-15T21:22:47.077Z,1744752167.077 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC 2025-04-15T21:22:47.080Z,1744752167.080 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg 2025-04-15T21:22:47.110Z,1744752167.110 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg 2025-04-15T21:22:47.142Z,1744752167.142 [MissionManager](INFO): DefineOutput sink:Science.PatchChl = nan ug/l 2025-04-15T21:22:47.149Z,1744752167.149 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDepth = nan m 2025-04-15T21:22:47.152Z,1744752167.152 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLatitude = nan arcdeg 2025-04-15T21:22:47.167Z,1744752167.167 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLongitude = nan arcdeg 2025-04-15T21:22:47.171Z,1744752167.171 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDistance = nan m 2025-04-15T21:22:47.182Z,1744752167.182 [MissionManager](INFO): DefineOutput sink:Science.PatchSalt = nan psu 2025-04-15T21:22:47.190Z,1744752167.190 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDepth = nan m 2025-04-15T21:22:47.226Z,1744752167.226 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLatitude = nan arcdeg 2025-04-15T21:22:47.241Z,1744752167.241 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLongitude = nan arcdeg 2025-04-15T21:22:47.244Z,1744752167.244 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDistance = nan m 2025-04-15T21:22:47.285Z,1744752167.285 [MissionManager](INFO): DefineOutput sink:Science.PatchOil = nan psu 2025-04-15T21:22:47.288Z,1744752167.288 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDepth = nan m 2025-04-15T21:22:47.297Z,1744752167.297 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLatitude = nan arcdeg 2025-04-15T21:22:47.309Z,1744752167.309 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLongitude = nan arcdeg 2025-04-15T21:22:47.327Z,1744752167.327 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDistance = nan m 2025-04-15T21:22:47.339Z,1744752167.339 [MissionManager](INFO): DefineOutput sink:Science.TriggeredOnChl = 0 bool 2025-04-15T21:22:47.358Z,1744752167.358 [MissionManager](INFO): DefineOutput sink:Science.ChlTriggering = nan ug/l 2025-04-15T21:22:47.466Z,1744752167.466 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:47.503Z,1744752167.503 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:22:47.565Z,1744752167.565 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:47.598Z,1744752167.598 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:47.662Z,1744752167.662 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0004.lzma.bak 2025-04-15T21:22:47.662Z,1744752167.662 [DataOverHttps](INFO): SBD MOMSN=24668009 2025-04-15T21:22:47.693Z,1744752167.693 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:22:47.728Z,1744752167.728 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:47.765Z,1744752167.765 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:47.871Z,1744752167.871 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:22:47.946Z,1744752167.946 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:47.987Z,1744752167.987 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:48.077Z,1744752168.077 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:48.146Z,1744752168.146 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:22:48.209Z,1744752168.209 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect. 2025-04-15T21:22:48.228Z,1744752168.228 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl 2025-04-15T21:22:48.228Z,1744752168.228 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl 2025-04-15T21:22:48.233Z,1744752168.233 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl 2025-04-15T21:22:49.091Z,1744752169.091 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/NeedComms.tl translated into: 1 10 20 NaN 1 1000 7 30 0 last time_fix was: first GPS update timeout Comms timed out after minutes second GPS update timeout 2025-04-15T21:22:49.115Z,1744752169.115 [MissionManager](INFO): DefineArg sink:NeedComms.DiveInterval = 1.000000 h 2025-04-15T21:22:49.137Z,1744752169.137 [MissionManager](INFO): DefineArg sink:NeedComms.WaitForPitchUp = 10.000000 min 2025-04-15T21:22:49.176Z,1744752169.176 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacePitch = 20.000000 arcdeg 2025-04-15T21:22:49.179Z,1744752169.179 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceDepthRate = nan m/s 2025-04-15T21:22:49.186Z,1744752169.186 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceSpeed = 1.000000 m/s 2025-04-15T21:22:49.214Z,1744752169.214 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacingTimeout = 1000.000000 s 2025-04-15T21:22:49.237Z,1744752169.237 [MissionManager](INFO): DefineArg sink:NeedComms.GPSTimeout = 7.000000 min 2025-04-15T21:22:49.240Z,1744752169.240 [MissionManager](INFO): DefineArg sink:NeedComms.CommsTimeout = 30.000000 min 2025-04-15T21:22:49.283Z,1744752169.283 [sink:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-04-15T21:22:49.384Z,1744752169.384 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:22:49.384Z,1744752169.384 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:22:49.394Z,1744752169.394 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:22:49.620Z,1744752169.620 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2025-04-15T21:22:49.666Z,1744752169.666 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinAltitude = 5.000000 m 2025-04-15T21:22:49.685Z,1744752169.685 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2025-04-15T21:22:49.716Z,1744752169.716 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepth = 200.000000 m 2025-04-15T21:22:49.719Z,1744752169.719 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinOffshore = 2000.000000 m 2025-04-15T21:22:49.748Z,1744752169.748 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2025-04-15T21:22:49.779Z,1744752169.779 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2025-04-15T21:22:49.869Z,1744752169.869 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2025-04-15T21:22:49.918Z,1744752169.918 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2025-04-15T21:22:49.918Z,1744752169.918 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2025-04-15T21:22:49.919Z,1744752169.919 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2025-04-15T21:22:49.984Z,1744752169.984 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2025-04-15T21:22:49.996Z,1744752169.996 [MissionManager](INFO): DefineArg sink:BackseatDriver.EnableBackseat = 0 bool 2025-04-15T21:22:49.999Z,1744752169.999 [sink:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2025-04-15T21:22:50.006Z,1744752170.006 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2025-04-15T21:22:50.006Z,1744752170.006 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2025-04-15T21:22:50.007Z,1744752170.007 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2025-04-15T21:22:50.383Z,1744752170.383 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2025-04-15T21:22:50.413Z,1744752170.413 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleAll = 0 bool 2025-04-15T21:22:50.415Z,1744752170.415 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad1 = 0 bool 2025-04-15T21:22:50.423Z,1744752170.423 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad2 = 0 bool 2025-04-15T21:22:50.462Z,1744752170.462 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad3 = 0 bool 2025-04-15T21:22:50.482Z,1744752170.482 [MissionManager](INFO): DefineArg sink:PowerOnly.EnabledPowerOnly = 0 bool 2025-04-15T21:22:50.509Z,1744752170.509 [sink:PowerOnly:E.Wait](DEBUG): Construct Wait. 2025-04-15T21:22:50.529Z,1744752170.529 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BallastAndTrim.tl 2025-04-15T21:22:50.529Z,1744752170.529 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BallastAndTrim.tl 2025-04-15T21:22:50.530Z,1744752170.530 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BallastAndTrim.tl 2025-04-15T21:22:52.019Z,1744752172.019 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BallastAndTrim.tl translated into: 25 0 0.4 20 0 20 10 45 10 0.25 15 99.9 1 0.25 0.005 0.00075 0 Going to target depth. Speed set to 0 13 0 Waiting for while pumping down to neutral. Moving to Timed out trying to reach the target depth. Stopping mission at current depth of stop 0 Waiting for the vehicle to settle. Depth = gfscan Running ballast and trim. Depth = 2025-04-15T21:22:52.043Z,1744752172.043 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepth = 25.000000 m 2025-04-15T21:22:52.070Z,1744752172.070 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSpeed = 0.000000 m/s 2025-04-15T21:22:52.085Z,1744752172.085 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthRate = 0.400000 m/s 2025-04-15T21:22:52.108Z,1744752172.108 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachPitchLimit = 20.000000 arcdeg 2025-04-15T21:22:52.111Z,1744752172.111 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSettleTimePreDive = 0.000000 min 2025-04-15T21:22:52.123Z,1744752172.123 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = 20.000000 min 2025-04-15T21:22:52.134Z,1744752172.134 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = 10.000000 min 2025-04-15T21:22:52.161Z,1744752172.161 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstTimeout = 45.000000 min 2025-04-15T21:22:52.164Z,1744752172.164 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MinEstTime = 10.000000 min 2025-04-15T21:22:52.175Z,1744752172.175 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = 0.250000 mm 2025-04-15T21:22:52.190Z,1744752172.190 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = 15.000000 cc 2025-04-15T21:22:52.227Z,1744752172.227 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstConfidence = 99.900002 % 2025-04-15T21:22:52.278Z,1744752172.278 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = 1.000000 m 2025-04-15T21:22:52.290Z,1744752172.290 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertMassDeadband = 0.250000 mm 2025-04-15T21:22:52.346Z,1744752172.346 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Construct. 2025-04-15T21:22:52.362Z,1744752172.362 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Construct Buoyancy. 2025-04-15T21:22:52.370Z,1744752172.370 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Construct. 2025-04-15T21:22:52.399Z,1744752172.399 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Construct Wait. 2025-04-15T21:22:52.411Z,1744752172.411 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Construct. 2025-04-15T21:22:52.418Z,1744752172.418 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Construct. 2025-04-15T21:22:52.450Z,1744752172.450 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute. 2025-04-15T21:22:52.488Z,1744752172.488 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Construct. 2025-04-15T21:22:52.499Z,1744752172.499 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Construct. 2025-04-15T21:22:52.571Z,1744752172.571 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Construct Wait. 2025-04-15T21:22:52.581Z,1744752172.581 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:E.Execute](DEBUG): Construct Execute. 2025-04-15T21:22:52.604Z,1744752172.604 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:G.](DEBUG): Construct BallastAndTrim. 2025-04-15T21:22:52.698Z,1744752172.698 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = reader:sink.DepthDeadband 2025-04-15T21:22:52.700Z,1744752172.700 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = reader:sink.TargetDepthTimeout 2025-04-15T21:22:52.710Z,1744752172.710 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = reader:sink.BTSettleTime 2025-04-15T21:22:52.712Z,1744752172.712 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstTimeout = reader:sink.EstimationTimeout 2025-04-15T21:22:52.734Z,1744752172.734 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MinEstTime = reader:sink.MinEstimationTime 2025-04-15T21:22:52.744Z,1744752172.744 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = reader:sink.MassEstimationErrorBound 2025-04-15T21:22:52.746Z,1744752172.746 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = reader:sink.BuoyEstimationErrorBound 2025-04-15T21:22:52.748Z,1744752172.748 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstConfidence = reader:sink.EstimationConfidence 2025-04-15T21:22:52.802Z,1744752172.802 [sink:FloatUp:A.Buoyancy](DEBUG): Construct Buoyancy. 2025-04-15T21:22:52.809Z,1744752172.809 [sink:FloatUp:B.Wait](DEBUG): Construct Wait. 2025-04-15T21:22:53.014Z,1744752173.014 [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 sink { arguments { SinkDuration = 2 hour """ Overall B&T timeout, or time to sink before ascending if not running B&T. Mission timeout will be SinkDuration + WaitToFloat. """ WaitToFloat = 20 minute """ Timeout for reaching surface threshold on float ascent, vehicle will drive up when reached """ Depth = 20 meter """ Target depth """ DepthDeadband = 1 meter """ How much vertical drift from the specified depth is allowed during the mission. """ SurfaceThreshold = 2.5 meter """ Surface threshold depth, relevant only to the ascent. """ TargetDepthTimeout = 20 minute """ Maximum wait time for the vehicle to reach the target depth. """ DoBallastAndTrim = false """ If true, run B&T, if false, just sit at depth. """ BTSettleTime = 10 minute """ If running B&T, how long to wait after reaching target depth before starting """ EstimationTimeout = 45 minute """ If running B&T, timeout for estimation. """ MinEstimationTime = 10 minute """ If running B&T, minimum time to run estimation before determining convergence (must be shorter than timeout). """ MassEstimationErrorBound = 0.5 millimeter """ If running B&T, desired range of the estimated sample mean from the true mean statistic (smaller values take longer to converge). """ BuoyEstimationErrorBound = 25 cubic_centimeter """ If running B&T, desired range of the estimated sample mean from the true mean statistic (smaller values take longer to converge). """ EstimationConfidence = 98 percent """ If running B&T, confidence level that the estimator has reached the desired error range (larger values take longer to converge). """ MinAltitude = 5 meter """ Minimum height above the sea floor for the entire mission. """ MaxDepth = 30 meter """ Maximum depth for the entire mission. """ MinOffshore = 2 kilometer """ Minimum offshore distance for the entire mission. """ SkipComms = false """ Skip start-of-mission GPS fix and comms if true """ } output { MissionTimeout = SinkDuration } timeout duration=MissionTimeout assign in sequence MissionTimeout = SinkDuration + WaitToFloat insert Insert/Science.tl insert id="NeedComms" Insert/NeedComms.tl assign in sequence NeedComms:DiveInterval = MissionTimeout insert Insert/StandardEnvelopes.tl assign in sequence StandardEnvelopes:MinAltitude = MinAltitude assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore insert Insert/BackseatDriver.tl insert Insert/PowerOnly.tl aggregate startComms { run in sequence break if ( SkipComms ) call id="StartingMission" refId="NeedComms" } aggregate RunSink { run in sequence timeout duration=SinkDuration insert Insert/BallastAndTrim.tl { redefineArg InsertDepthDeadband = DepthDeadband redefineArg InsertApproachDepthTimeout = TargetDepthTimeout redefineArg InsertSettleTime = BTSettleTime redefineArg EstTimeout = EstimationTimeout redefineArg MinEstTime = MinEstimationTime redefineArg MassEstErrorBound = MassEstimationErrorBound redefineArg BuoyEstErrorBound = BuoyEstimationErrorBound redefineArg EstConfidence = EstimationConfidence } aggregate RunBallastAndTrim { run in sequence break if ( isNaN ( Depth ) or not DoBallastAndTrim ) assign in sequence BallastAndTrim:InsertDepth = Depth call refId="BallastAndTrim" } aggregate JustSink { run in sequence break if ( isNaN ( Depth ) or DoBallastAndTrim ) assign in sequence BallastAndTrim:InsertDepth = Depth # The B&T insert will never actually invoke the B&T behavior here. # This is a little bit of a hack to avoid duplicating the ApproachDepth etc. # logic the B&T insert uses. assign in sequence BTSettleTime = SinkDuration call refId="BallastAndTrim" } } aggregate FloatUp { """ Float to surface instead of driving. """ run in sequence break if ( Universal:depth < SurfaceThreshold ) behavior Guidance:Buoyancy { run in parallel set position = Control:VerticalControl.buoyancyDefault } behavior Guidance:Wait { run in sequence set duration = WaitToFloat } } call id="EndingMission" refId="NeedComms" } 2025-04-15T21:22:53.015Z,1744752173.015 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/sink.tl id=sink 2025-04-15T21:23:13.913Z,1744752193.913 [CommandExec](IMPORTANT): got command set sink.SinkDuration 30 minute 2025-04-15T21:23:13.914Z,1744752193.914 [CommandExec](IMPORTANT): got command set sink.Depth 1 meter 2025-04-15T21:23:13.914Z,1744752193.914 [CommandExec](IMPORTANT): got command set sink.DepthDeadband .25 meter 2025-04-15T21:23:13.915Z,1744752193.915 [CommandExec](IMPORTANT): got command set sink.SurfaceThreshold 0.1 meter 2025-04-15T21:23:13.916Z,1744752193.916 [CommandExec](IMPORTANT): got command set sink.MinAltitude 0.01 meter 2025-04-15T21:23:13.920Z,1744752193.920 [CommandExec](IMPORTANT): got command set sink.MaxDepth 2 meter 2025-04-15T21:23:13.921Z,1744752193.921 [CommandExec](IMPORTANT): got command set sink.MinOffshore 0.00001 kilometer 2025-04-15T21:23:16.951Z,1744752196.951 [CommandExec](IMPORTANT): got command set sink.SkipComms 1 bool 2025-04-15T21:23:16.951Z,1744752196.951 [CommandExec](IMPORTANT): got command run 2025-04-15T21:23:16.960Z,1744752196.960 [CommandExec](IMPORTANT): Running 2025-04-15T21:23:17.378Z,1744752197.378 [DefaultTankUndock] Stopped 2025-04-15T21:23:17.378Z,1744752197.378 [DefaultTankUndock](DEBUG): Aggregate::uninitialize DefaultTankUndock 2025-04-15T21:23:17.378Z,1744752197.378 [DefaultTankUndock:B.GoToSurface] Stopped 2025-04-15T21:23:17.378Z,1744752197.378 [DefaultTankUndock:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-15T21:23:17.378Z,1744752197.378 [DefaultTankUndock:CheckIn] Stopped 2025-04-15T21:23:17.378Z,1744752197.378 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultTankUndock:CheckIn 2025-04-15T21:23:17.378Z,1744752197.378 [DefaultTankUndock:CheckIn:Read_Iridium] Stopped 2025-04-15T21:23:17.379Z,1744752197.379 [MissionManager](IMPORTANT): Started mission sink 2025-04-15T21:23:17.379Z,1744752197.379 [sink] Running Loop=1 2025-04-15T21:23:17.379Z,1744752197.379 [sink](DEBUG): Aggregate::initialize sink 2025-04-15T21:23:17.379Z,1744752197.379 [sink:Science] Running Loop=1 2025-04-15T21:23:17.379Z,1744752197.379 [sink:Science](DEBUG): Aggregate::initialize sink:Science 2025-04-15T21:23:17.379Z,1744752197.379 [sink:Science:A] Running Loop=1 2025-04-15T21:23:17.379Z,1744752197.379 [sink:Science:B] Running Loop=1 2025-04-15T21:23:17.379Z,1744752197.379 [sink:Science:C] Running Loop=1 2025-04-15T21:23:17.379Z,1744752197.379 [sink:Science:D] Running Loop=1 2025-04-15T21:23:17.379Z,1744752197.379 [sink:Science:E] Running Loop=1 2025-04-15T21:23:17.380Z,1744752197.380 [sink:Science:F] Running Loop=1 2025-04-15T21:23:17.380Z,1744752197.380 [sink:Science:Read_Oil] Running Loop=1 2025-04-15T21:23:17.380Z,1744752197.380 [sink:Science:PeakDetectChl] Running Loop=1 2025-04-15T21:23:17.380Z,1744752197.380 [sink:Science:PeakDetectChl](DEBUG): Aggregate::initialize sink:Science:PeakDetectChl 2025-04-15T21:23:17.380Z,1744752197.380 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.380Z,1744752197.380 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.387Z,1744752197.387 [sink:Science:HighestChlPeakReport] Running Loop=1 2025-04-15T21:23:17.387Z,1744752197.387 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestChlPeakReport 2025-04-15T21:23:17.387Z,1744752197.387 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:23:17.387Z,1744752197.387 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:23:17.388Z,1744752197.388 [sink:Science:PeakDetectNO3] Running Loop=1 2025-04-15T21:23:17.388Z,1744752197.388 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sink:Science:PeakDetectNO3 2025-04-15T21:23:17.388Z,1744752197.388 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.388Z,1744752197.388 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.401Z,1744752197.401 [sink:Science:PeakDetectOil] Running Loop=1 2025-04-15T21:23:17.401Z,1744752197.401 [sink:Science:PeakDetectOil](DEBUG): Aggregate::initialize sink:Science:PeakDetectOil 2025-04-15T21:23:17.401Z,1744752197.401 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.401Z,1744752197.401 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.404Z,1744752197.404 [sink:Science:HighestOilPeakReport] Running Loop=1 2025-04-15T21:23:17.404Z,1744752197.404 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestOilPeakReport 2025-04-15T21:23:17.408Z,1744752197.408 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:23:17.408Z,1744752197.408 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:23:17.409Z,1744752197.409 [sink:Science:PeakDetectFDOM] Running Loop=1 2025-04-15T21:23:17.409Z,1744752197.409 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sink:Science:PeakDetectFDOM 2025-04-15T21:23:17.409Z,1744752197.409 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.409Z,1744752197.409 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.411Z,1744752197.411 [sink:Science:PeakDetectSalinity] Running Loop=1 2025-04-15T21:23:17.411Z,1744752197.411 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize sink:Science:PeakDetectSalinity 2025-04-15T21:23:17.411Z,1744752197.411 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.411Z,1744752197.411 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.449Z,1744752197.449 [sink:Science:HighestSaltPeakReport] Running Loop=1 2025-04-15T21:23:17.449Z,1744752197.449 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestSaltPeakReport 2025-04-15T21:23:17.449Z,1744752197.449 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:23:17.449Z,1744752197.449 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:23:17.449Z,1744752197.449 [sink:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1 2025-04-15T21:23:17.450Z,1744752197.450 [sink:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreLMavgROI 2025-04-15T21:23:17.450Z,1744752197.450 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.450Z,1744752197.450 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.450Z,1744752197.450 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_LM_AvgRois , but backseat URI detected. Waiting for presence. 2025-04-15T21:23:17.451Z,1744752197.451 [sink:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1 2025-04-15T21:23:17.451Z,1744752197.451 [sink:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreHMavgROI 2025-04-15T21:23:17.452Z,1744752197.452 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.452Z,1744752197.452 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.452Z,1744752197.452 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_HM_AvgRois , but backseat URI detected. Waiting for presence. 2025-04-15T21:23:17.462Z,1744752197.462 [sink:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1 2025-04-15T21:23:17.462Z,1744752197.462 [sink:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreDiatoms 2025-04-15T21:23:17.462Z,1744752197.462 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.462Z,1744752197.462 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.463Z,1744752197.463 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_diatoms , but backseat URI detected. Waiting for presence. 2025-04-15T21:23:17.464Z,1744752197.464 [sink:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1 2025-04-15T21:23:17.464Z,1744752197.464 [sink:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreDinoflagellates 2025-04-15T21:23:17.464Z,1744752197.464 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:23:17.489Z,1744752197.489 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:23:17.489Z,1744752197.489 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_dinoflagellates , but backseat URI detected. Waiting for presence. 2025-04-15T21:23:17.490Z,1744752197.490 [sink:Science:ChlThreshTrigger] Running Loop=1 2025-04-15T21:23:17.490Z,1744752197.490 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize sink:Science:ChlThreshTrigger 2025-04-15T21:23:17.490Z,1744752197.490 [sink:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1 2025-04-15T21:23:17.490Z,1744752197.490 [sink:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize. 2025-04-15T21:23:17.491Z,1744752197.491 [sink:Science:OceanCurrent] Running Loop=1 2025-04-15T21:23:17.491Z,1744752197.491 [sink:Science:OceanCurrent](DEBUG): Aggregate::initialize sink:Science:OceanCurrent 2025-04-15T21:23:17.491Z,1744752197.491 [sink:Science:OceanCurrent:A.] Running Loop=1 2025-04-15T21:23:17.491Z,1744752197.491 [sink:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2025-04-15T21:23:17.491Z,1744752197.491 [sink:StandardEnvelopes] Running Loop=1 2025-04-15T21:23:17.491Z,1744752197.491 [sink:StandardEnvelopes](DEBUG): Aggregate::initialize sink:StandardEnvelopes 2025-04-15T21:23:17.491Z,1744752197.491 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-04-15T21:23:17.492Z,1744752197.492 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2025-04-15T21:23:17.492Z,1744752197.492 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-04-15T21:23:17.492Z,1744752197.492 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2025-04-15T21:23:17.501Z,1744752197.501 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-04-15T21:23:17.501Z,1744752197.501 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2025-04-15T21:23:17.501Z,1744752197.501 [sink:BackseatDriver] Running Loop=1 2025-04-15T21:23:17.501Z,1744752197.501 [sink:BackseatDriver](DEBUG): Aggregate::initialize sink:BackseatDriver 2025-04-15T21:23:17.502Z,1744752197.502 [sink:BackseatDriver:A.BackseatDriver] Running Loop=1 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly] Running Loop=1 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly](DEBUG): Aggregate::initialize sink:PowerOnly 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly:A] Running Loop=1 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly:B] Running Loop=1 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly:C] Running Loop=1 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly:D] Running Loop=1 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly:E.Wait] Running Loop=1 2025-04-15T21:23:17.502Z,1744752197.502 [sink:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:23:17.502Z,1744752197.502 [sink:A] Running Loop=1 2025-04-15T21:23:17.503Z,1744752197.503 [sink:PowerOnly] Running Loop=1 2025-04-15T21:23:17.503Z,1744752197.503 [sink:PowerOnly:D] Stopped 2025-04-15T21:23:17.503Z,1744752197.503 [sink:PowerOnly:C] Stopped 2025-04-15T21:23:17.503Z,1744752197.503 [sink:PowerOnly:B] Stopped 2025-04-15T21:23:17.503Z,1744752197.503 [sink:PowerOnly:A] Stopped 2025-04-15T21:23:17.503Z,1744752197.503 [sink:BackseatDriver] Running Loop=1 2025-04-15T21:23:17.504Z,1744752197.504 [sink:StandardEnvelopes] Running Loop=1 2025-04-15T21:23:17.504Z,1744752197.504 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-04-15T21:23:17.513Z,1744752197.513 [sink:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE 2025-04-15T21:23:17.537Z,1744752197.537 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-04-15T21:23:17.538Z,1744752197.538 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-04-15T21:23:17.538Z,1744752197.538 [sink:Science] Running Loop=1 2025-04-15T21:23:17.539Z,1744752197.539 [sink:Science:ChlThreshTrigger] Stopped 2025-04-15T21:23:17.540Z,1744752197.540 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize sink:Science:ChlThreshTrigger 2025-04-15T21:23:17.540Z,1744752197.540 [sink:Science:ChlThreshTrigger:A.ValueDetect] Stopped 2025-04-15T21:23:17.540Z,1744752197.540 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize. 2025-04-15T21:23:17.540Z,1744752197.540 [sink:Science:PeakDetectPlanktivoreDinoflagellates] Stopped 2025-04-15T21:23:17.540Z,1744752197.540 [sink:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreDinoflagellates 2025-04-15T21:23:17.540Z,1744752197.540 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.548Z,1744752197.548 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.548Z,1744752197.548 [sink:Science:PeakDetectPlanktivoreDiatoms] Stopped 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreDiatoms 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreHMavgROI] Stopped 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreHMavgROI 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreLMavgROI] Stopped 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreLMavgROI 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:HighestSaltPeakReport] Stopped 2025-04-15T21:23:17.549Z,1744752197.549 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestSaltPeakReport 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectSalinity] Stopped 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectSalinity 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectFDOM] Stopped 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectFDOM 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:HighestOilPeakReport] Stopped 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestOilPeakReport 2025-04-15T21:23:17.550Z,1744752197.550 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectOil] Stopped 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectOil 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectNO3] Stopped 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectNO3 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:HighestChlPeakReport] Stopped 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestChlPeakReport 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:23:17.551Z,1744752197.551 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:23:17.552Z,1744752197.552 [sink:Science:PeakDetectChl] Stopped 2025-04-15T21:23:17.552Z,1744752197.552 [sink:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectChl 2025-04-15T21:23:17.552Z,1744752197.552 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2025-04-15T21:23:17.552Z,1744752197.552 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:23:17.552Z,1744752197.552 [sink:Science:OceanCurrent:A.] Running Loop=1 2025-04-15T21:23:17.562Z,1744752197.562 [sink:Science:Read_Oil] Stopped 2025-04-15T21:23:17.562Z,1744752197.562 [sink:Science:F] Running Loop=1 2025-04-15T21:23:17.563Z,1744752197.563 [sink:Science:F](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.average_bioluminescence 2025-04-15T21:23:17.563Z,1744752197.563 [sink:Science:E] Running Loop=1 2025-04-15T21:23:17.564Z,1744752197.564 [sink:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2025-04-15T21:23:17.564Z,1744752197.564 [sink:Science:D] Stopped 2025-04-15T21:23:17.564Z,1744752197.564 [sink:Science:C] Running Loop=1 2025-04-15T21:23:17.570Z,1744752197.570 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2025-04-15T21:23:17.571Z,1744752197.571 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2025-04-15T21:23:17.571Z,1744752197.571 [sink:Science:B] Running Loop=1 2025-04-15T21:23:17.571Z,1744752197.571 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2025-04-15T21:23:17.572Z,1744752197.572 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2025-04-15T21:23:17.593Z,1744752197.593 [sink:Science:A] Stopped 2025-04-15T21:23:17.593Z,1744752197.593 [sink:A] Stopped 2025-04-15T21:23:17.593Z,1744752197.593 [sink:D] Running Loop=1 2025-04-15T21:23:17.606Z,1744752197.606 [HorizontalControl](DEBUG): kpHeading = 0.400000 2025-04-15T21:23:17.606Z,1744752197.606 [HorizontalControl](DEBUG): kiHeading = 0.001000 2025-04-15T21:23:17.606Z,1744752197.606 [HorizontalControl](DEBUG): kdHeading = 0.050000 2025-04-15T21:23:17.768Z,1744752197.768 [sink:D] Stopped 2025-04-15T21:23:17.768Z,1744752197.768 [sink:F] Running Loop=1 2025-04-15T21:23:17.827Z,1744752197.827 [WetLabsBB2FL](INFO): Powering up 2025-04-15T21:23:18.154Z,1744752198.154 [sink:F] Stopped 2025-04-15T21:23:18.154Z,1744752198.154 [sink:G] Running Loop=1 2025-04-15T21:23:18.185Z,1744752198.185 [WetLabsUBAT](INFO): Powering up 2025-04-15T21:23:18.560Z,1744752198.560 [sink:G] Stopped 2025-04-15T21:23:18.561Z,1744752198.561 [sink:H] Running Loop=1 2025-04-15T21:23:18.938Z,1744752198.938 [sink:H] Stopped 2025-04-15T21:23:18.938Z,1744752198.938 [sink:startComms] Running Loop=1 2025-04-15T21:23:18.938Z,1744752198.938 [sink:startComms](DEBUG): Aggregate::initialize sink:startComms 2025-04-15T21:23:18.938Z,1744752198.938 [sink:startComms:StartingMission] Running Loop=1 2025-04-15T21:23:18.938Z,1744752198.938 [sink:startComms:StartingMission](DEBUG): Aggregate::initialize sink:startComms:StartingMission 2025-04-15T21:23:19.407Z,1744752199.407 [sink:startComms] Stopped 2025-04-15T21:23:19.407Z,1744752199.407 [sink:startComms](DEBUG): Aggregate::uninitialize sink:startComms 2025-04-15T21:23:19.407Z,1744752199.407 [sink:startComms:StartingMission] Stopped 2025-04-15T21:23:19.407Z,1744752199.407 [sink:startComms:StartingMission](DEBUG): Aggregate::uninitialize sink:startComms:StartingMission 2025-04-15T21:23:19.407Z,1744752199.407 [sink:RunSink] Running Loop=1 2025-04-15T21:23:19.408Z,1744752199.408 [sink:RunSink](DEBUG): Aggregate::initialize sink:RunSink 2025-04-15T21:23:19.408Z,1744752199.408 [sink:RunSink:RunBallastAndTrim] Running Loop=1 2025-04-15T21:23:19.408Z,1744752199.408 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:RunBallastAndTrim 2025-04-15T21:23:19.408Z,1744752199.408 [sink:RunSink:RunBallastAndTrim:A] Running Loop=1 2025-04-15T21:23:19.413Z,1744752199.413 [sink:NeedComms] Running Loop=1 2025-04-15T21:23:19.414Z,1744752199.414 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms 2025-04-15T21:23:19.414Z,1744752199.414 [sink:NeedComms:B.GoToSurface] Running Loop=1 2025-04-15T21:23:19.414Z,1744752199.414 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-15T21:23:19.414Z,1744752199.414 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2025-04-15T21:23:19.415Z,1744752199.415 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2025-04-15T21:23:19.415Z,1744752199.415 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2025-04-15T21:23:19.415Z,1744752199.415 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2025-04-15T21:23:19.415Z,1744752199.415 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-15T21:23:19.416Z,1744752199.416 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-15T21:23:19.420Z,1744752199.420 [sink:NeedComms:A] Running Loop=1 2025-04-15T21:23:19.422Z,1744752199.422 [sink:NeedComms:A](INFO): last time_fix was: 1744752056.000000 second since 1970/01/01T00:00:00Z 2025-04-15T21:23:19.422Z,1744752199.422 [sink:NeedComms:A] Stopped 2025-04-15T21:23:19.726Z,1744752199.726 [sink:RunSink:RunBallastAndTrim] Stopped 2025-04-15T21:23:19.726Z,1744752199.726 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:RunBallastAndTrim 2025-04-15T21:23:19.726Z,1744752199.726 [sink:RunSink:RunBallastAndTrim:A] Stopped 2025-04-15T21:23:19.726Z,1744752199.726 [sink:RunSink:JustSink] Running Loop=1 2025-04-15T21:23:19.726Z,1744752199.726 [sink:RunSink:JustSink](DEBUG): Aggregate::initialize sink:RunSink:JustSink 2025-04-15T21:23:19.727Z,1744752199.727 [sink:RunSink:JustSink:A] Running Loop=1 2025-04-15T21:23:19.729Z,1744752199.729 [sink:NeedComms:C] Running Loop=1 2025-04-15T21:23:20.123Z,1744752200.123 [sink:RunSink:JustSink:A] Stopped 2025-04-15T21:23:20.123Z,1744752200.123 [sink:RunSink:JustSink:B] Running Loop=1 2025-04-15T21:23:20.141Z,1744752200.141 [sink:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-04-15T21:23:20.562Z,1744752200.562 [sink:RunSink:JustSink:B] Stopped 2025-04-15T21:23:20.562Z,1744752200.562 [sink:RunSink:JustSink:C] Running Loop=1 2025-04-15T21:23:20.562Z,1744752200.562 [sink:RunSink:JustSink:C](DEBUG): Aggregate::initialize sink:RunSink:JustSink:C 2025-04-15T21:23:20.688Z,1744752200.688 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250415T211501/Courier0007.lzma 2025-04-15T21:23:20.937Z,1744752200.937 [sink:RunSink:BallastAndTrim] Running Loop=1 2025-04-15T21:23:20.937Z,1744752200.937 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim 2025-04-15T21:23:20.937Z,1744752200.937 [sink:RunSink:BallastAndTrim:A] Running Loop=1 2025-04-15T21:23:20.937Z,1744752200.937 [sink:RunSink:BallastAndTrim:B] Running Loop=1 2025-04-15T21:23:20.938Z,1744752200.938 [sink:RunSink:BallastAndTrim:C] Running Loop=1 2025-04-15T21:23:20.938Z,1744752200.938 [sink:RunSink:BallastAndTrim:D] Running Loop=1 2025-04-15T21:23:20.938Z,1744752200.938 [sink:RunSink:BallastAndTrim:E] Running Loop=1 2025-04-15T21:23:20.938Z,1744752200.938 [sink:RunSink:BallastAndTrim:F] Running Loop=1 2025-04-15T21:23:20.940Z,1744752200.940 [sink:RunSink:BallastAndTrim:F](INFO): Going to target depth. Speed set to 0.000000 m/s 2025-04-15T21:23:20.940Z,1744752200.940 [sink:RunSink:BallastAndTrim:F] Stopped 2025-04-15T21:23:20.940Z,1744752200.940 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Running Loop=1 2025-04-15T21:23:20.940Z,1744752200.940 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth 2025-04-15T21:23:20.940Z,1744752200.940 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2025-04-15T21:23:20.940Z,1744752200.940 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Running Loop=1 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Running Loop=1 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Initialize. 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Running Loop=1 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Initialize Buoyancy Component. 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Running Loop=1 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Initialize. 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Running Loop=1 2025-04-15T21:23:20.941Z,1744752200.941 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive 2025-04-15T21:23:20.942Z,1744752200.942 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Running Loop=1 2025-04-15T21:23:20.942Z,1744752200.942 [sink:RunSink:BallastAndTrim:E] Running Loop=1 2025-04-15T21:23:20.943Z,1744752200.943 [sink:RunSink:BallastAndTrim:D] Running Loop=1 2025-04-15T21:23:20.943Z,1744752200.943 [sink:RunSink:BallastAndTrim:C] Running Loop=1 2025-04-15T21:23:20.943Z,1744752200.943 [sink:RunSink:BallastAndTrim:B] Running Loop=1 2025-04-15T21:23:20.943Z,1744752200.943 [sink:RunSink:BallastAndTrim:A] Running Loop=1 2025-04-15T21:23:21.398Z,1744752201.398 [CTD_Seabird](ERROR): Failed to parse device response: 2025-04-15T21:23:21.442Z,1744752201.442 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A](INFO): Waiting for 0.000000 min while pumping down to neutral. 2025-04-15T21:23:21.442Z,1744752201.442 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Stopped 2025-04-15T21:23:21.442Z,1744752201.442 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Running Loop=1 2025-04-15T21:23:21.442Z,1744752201.442 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:23:21.443Z,1744752201.443 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Stopped 2025-04-15T21:23:21.443Z,1744752201.443 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold 2025-04-15T21:23:21.443Z,1744752201.443 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Stopped 2025-04-15T21:23:21.443Z,1744752201.443 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Stopped 2025-04-15T21:23:21.443Z,1744752201.443 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2025-04-15T21:23:21.443Z,1744752201.443 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Stopped 2025-04-15T21:23:21.443Z,1744752201.443 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2025-04-15T21:23:21.690Z,1744752201.690 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0007.lzma.bak 2025-04-15T21:23:21.690Z,1744752201.690 [DataOverHttps](INFO): SBD MOMSN=24668019 2025-04-15T21:23:21.738Z,1744752201.738 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212321.00,A,3648.15933,N,12147.28016,W,0.039,0.00,150425,,,A*78 2025-04-15T21:23:21.740Z,1744752201.740 [NAL9602](INFO): GPS fix at 20250415T212321: (36.802656, -121.788003) 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](INFO): Done Waiting. 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Stopped 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Stopped 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Running Loop=1 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth 2025-04-15T21:23:21.774Z,1744752201.774 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2025-04-15T21:23:21.775Z,1744752201.775 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Initialize. 2025-04-15T21:23:21.775Z,1744752201.775 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Running Loop=1 2025-04-15T21:23:21.782Z,1744752201.782 [sink:NeedComms:C] Stopped 2025-04-15T21:23:21.782Z,1744752201.782 [sink:NeedComms:D] Running Loop=1 2025-04-15T21:23:22.171Z,1744752202.171 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2025-04-15T21:23:22.172Z,1744752202.172 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A](INFO): Moving to 1.000000 m 2025-04-15T21:23:22.172Z,1744752202.172 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Stopped 2025-04-15T21:23:22.173Z,1744752202.173 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Running Loop=1 2025-04-15T21:23:22.173Z,1744752202.173 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Initialize. 2025-04-15T21:23:22.196Z,1744752202.196 [sink:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-15T21:23:28.351Z,1744752208.351 [WetLabsUBAT](FAULT): UBAT flow rate is below the specified threshold of 0.05 l/s. 2025-04-15T21:23:42.817Z,1744752222.817 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, -0.42, -0.02, , 10.06, 0.00 2025-04-15T21:23:43.362Z,1744752223.362 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250415T211501/Courier0010.lzma 2025-04-15T21:23:44.364Z,1744752224.364 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0010.lzma.bak 2025-04-15T21:23:44.365Z,1744752224.365 [DataOverHttps](INFO): SBD MOMSN=24668025 2025-04-15T21:23:52.502Z,1744752232.502 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2025-04-15T21:23:52.584Z,1744752232.584 [NAL9602](ERROR): received: +CSQ:0 OK 2025-04-15T21:24:07.309Z,1744752247.309 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250415T211501/Courier0013.lzma 2025-04-15T21:24:08.310Z,1744752248.310 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0013.lzma.bak 2025-04-15T21:24:08.310Z,1744752248.310 [DataOverHttps](INFO): SBD MOMSN=24668027 2025-04-15T21:24:41.695Z,1744752281.695 [DataOverHttps](INFO): Sending 1269 bytes from file Logs/20250415T210417/Express0001.lzma 2025-04-15T21:24:42.694Z,1744752282.694 [DataOverHttps](INFO): Moved sent file to Logs/20250415T210417/Express0001.lzma.bak 2025-04-15T21:24:42.694Z,1744752282.694 [DataOverHttps](INFO): SBD MOMSN=24668030 2025-04-15T21:24:58.090Z,1744752298.090 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, -2, -1,A 2025-04-15T21:25:08.450Z,1744752308.450 [DataOverHttps](INFO): Sending 1324 bytes from file Logs/20250415T211501/Express0001.lzma 2025-04-15T21:25:09.446Z,1744752309.446 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0001.lzma.bak 2025-04-15T21:25:09.446Z,1744752309.446 [DataOverHttps](INFO): SBD MOMSN=24668061 2025-04-15T21:25:33.917Z,1744752333.917 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20250415T211501/Express0005.lzma 2025-04-15T21:25:34.918Z,1744752334.918 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0005.lzma.bak 2025-04-15T21:25:34.918Z,1744752334.918 [DataOverHttps](INFO): SBD MOMSN=24668096 2025-04-15T21:25:55.849Z,1744752355.849 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2025-04-15T21:26:00.425Z,1744752360.425 [DataOverHttps](INFO): Sending 327 bytes from file Logs/20250415T211501/Express0008.lzma 2025-04-15T21:26:01.427Z,1744752361.427 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0008.lzma.bak 2025-04-15T21:26:01.427Z,1744752361.427 [DataOverHttps](INFO): SBD MOMSN=24668100 2025-04-15T21:26:13.120Z,1744752373.120 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2025-04-15T21:26:29.623Z,1744752389.623 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position 2025-04-15T21:26:29.867Z,1744752389.867 [Reporter](INFO): platform_buoyancy_position 990.301025 cc 2025-04-15T21:26:31.485Z,1744752391.485 [DataOverHttps](IMPORTANT): SBD MTMSN=20250415T212630 2025-04-15T21:26:40.449Z,1744752400.449 [DataOverHttps](INFO): Sending 271 bytes from file Logs/20250415T211501/Express0011.lzma 2025-04-15T21:26:40.452Z,1744752400.452 [DataOverHttps](INFO): Received command: sched 20250415T2135 "load Engineering/OnDock.tl;set OnDock.DockedTime .5 h;set OnDock.MinAltitude 0.1 m;set OnDock.MinOffshore 0.0001 km;run" 2025-04-15T21:26:40.470Z,1744752400.470 [CommandExec](IMPORTANT): got command schedule 20250415T213500 "load Engineering/OnDock.tl;set OnDock.DockedTime .5 h;set OnDock.MinAltitude 0.1 m;set OnDock.MinOffshore 0.0001 km;run" 2025-04-15T21:26:40.470Z,1744752400.470 [CommandExec](IMPORTANT): Scheduled #3: "load Engineering/OnDock.tl;set OnDock.DockedTime .5 h;set OnDock.MinAltitude 0.1 m;set OnDock.MinOffshore 0.0001 km;run", AT TIME: 2025-04-15T21:35:00Z 2025-04-15T21:26:41.830Z,1744752401.830 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0011.lzma.bak 2025-04-15T21:26:41.830Z,1744752401.830 [DataOverHttps](INFO): SBD MOMSN=24668107 2025-04-15T21:27:04.517Z,1744752424.517 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250415T211501/Courier0016.lzma 2025-04-15T21:27:05.514Z,1744752425.514 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Courier0016.lzma.bak 2025-04-15T21:27:05.514Z,1744752425.514 [DataOverHttps](INFO): SBD MOMSN=24668115 2025-04-15T21:27:08.175Z,1744752428.175 [NAL9602](INFO): SBD MO Status=2, MOMSN=47931, MT Status=2, MTMSN=0 2025-04-15T21:27:08.175Z,1744752428.175 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:27:18.189Z,1744752438.189 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2025-04-15T21:27:19.084Z,1744752439.084 [NAL9602](INFO): SBD MO Status=0, MOMSN=47931, MT Status=0, MTMSN=0 2025-04-15T21:27:19.084Z,1744752439.084 [NAL9602](INFO): No messages in MT queue 2025-04-15T21:27:23.152Z,1744752443.152 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2025-04-15T21:27:23.152Z,1744752443.152 [RDI_Pathfinder] Communications Fault, FailCount= 1 2025-04-15T21:27:23.152Z,1744752443.152 [RDI_Pathfinder](ERROR): Communications Fault 2025-04-15T21:27:23.284Z,1744752443.284 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2025-04-15T21:27:23.526Z,1744752443.526 [RDI_Pathfinder](INFO): Powering down 2025-04-15T21:27:24.475Z,1744752444.475 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2025-04-15T21:27:24.475Z,1744752444.475 [RDI_Pathfinder] No Fault, FailCount= 1 2025-04-15T21:27:24.734Z,1744752444.734 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2025-04-15T21:27:30.823Z,1744752450.823 [DataOverHttps](INFO): Sending 388 bytes from file Logs/20250415T211501/Express0014.lzma 2025-04-15T21:27:31.830Z,1744752451.830 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0014.lzma.bak 2025-04-15T21:27:31.831Z,1744752451.831 [DataOverHttps](INFO): SBD MOMSN=24668117 2025-04-15T21:27:43.337Z,1744752463.337 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 07.25, 89.72, 92.81, 99.00 2025-04-15T21:27:49.792Z,1744752469.792 [NAL9602](INFO): Not Powering down - fast GPS 2025-04-15T21:27:56.351Z,1744752476.351 [DataOverHttps](INFO): Sending 695 bytes from file Logs/20250415T211501/Express0017.lzma 2025-04-15T21:27:57.347Z,1744752477.347 [DataOverHttps](INFO): Moved sent file to Logs/20250415T211501/Express0017.lzma.bak 2025-04-15T21:27:57.347Z,1744752477.347 [DataOverHttps](INFO): SBD MOMSN=24668138 2025-04-15T21:28:04.001Z,1744752484.001 [sink:NeedComms:D] Stopped 2025-04-15T21:28:04.002Z,1744752484.002 [sink:NeedComms:E] Running Loop=1 2025-04-15T21:28:04.487Z,1744752484.487 [sink:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-04-15T21:28:05.963Z,1744752485.963 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212805.00,A,3648.16504,N,12147.28256,W,0.544,157.35,150425,,,D*77 2025-04-15T21:28:05.978Z,1744752485.978 [NAL9602](INFO): GPS fix at 20250415T212805: (36.802751, -121.788043) 2025-04-15T21:28:06.082Z,1744752486.082 [sink:NeedComms:E] Stopped 2025-04-15T21:28:06.083Z,1744752486.083 [sink:NeedComms](INFO): Completed sink:NeedComms 2025-04-15T21:28:06.083Z,1744752486.083 [sink:NeedComms] Stopped 2025-04-15T21:28:06.083Z,1744752486.083 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms 2025-04-15T21:28:06.083Z,1744752486.083 [sink:NeedComms:B.GoToSurface] Stopped 2025-04-15T21:28:06.083Z,1744752486.083 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-15T21:28:08.768Z,1744752488.768 [Reporter](INFO): platform_buoyancy_position 986.003418 cc 2025-04-15T21:28:09.738Z,1744752489.738 [Reporter](INFO): platform_buoyancy_position 983.854614 cc 2025-04-15T21:28:10.430Z,1744752490.430 [Reporter](INFO): platform_buoyancy_position 973.244873 cc 2025-04-15T21:28:11.171Z,1744752491.171 [Reporter](INFO): platform_buoyancy_position 971.096069 cc 2025-04-15T21:28:11.780Z,1744752491.780 [DockingStepper](ERROR): getADC uart error serial timeout 2025-04-15T21:28:11.781Z,1744752491.781 [DockingStepper](FAULT): uart error - getPosition..serial timeout 2025-04-15T21:28:11.781Z,1744752491.781 [DockingStepper] Communications Fault, FailCount= 1 2025-04-15T21:28:11.781Z,1744752491.781 [DockingStepper](ERROR): Communications Fault 2025-04-15T21:28:11.819Z,1744752491.819 [CBIT](ERROR): Communications Fault in component: DockingStepper 2025-04-15T21:28:11.821Z,1744752491.821 [Reporter](INFO): platform_buoyancy_position 966.798462 cc 2025-04-15T21:28:12.069Z,1744752492.069 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2025-04-15T21:28:12.395Z,1744752492.395 [DockingStepper](INFO): Stop 2025-04-15T21:28:12.395Z,1744752492.395 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2025-04-15T21:28:12.395Z,1744752492.395 [DockingStepper](INFO): Powering down 2025-04-15T21:28:12.492Z,1744752492.492 [Reporter](INFO): platform_buoyancy_position 960.217773 cc 2025-04-15T21:28:12.829Z,1744752492.829 [DockingStepper](INFO): Stopping 2025-04-15T21:28:12.875Z,1744752492.875 [Reporter](INFO): platform_buoyancy_position 958.203247 cc 2025-04-15T21:28:13.174Z,1744752493.174 [DockingStepper](INFO): Stopping 2025-04-15T21:28:13.186Z,1744752493.186 [Reporter](INFO): platform_buoyancy_position 954.174316 cc 2025-04-15T21:28:13.866Z,1744752493.866 [DockingStepper](INFO): Stopping 2025-04-15T21:28:13.874Z,1744752493.874 [Reporter](INFO): platform_buoyancy_position 947.459229 cc 2025-04-15T21:28:14.491Z,1744752494.491 [DockingStepper](INFO): Stopping 2025-04-15T21:28:14.513Z,1744752494.513 [Reporter](INFO): platform_buoyancy_position 943.027344 cc 2025-04-15T21:28:15.081Z,1744752495.081 [DockingStepper](INFO): Stopping 2025-04-15T21:28:15.097Z,1744752495.097 [Reporter](INFO): platform_buoyancy_position 938.729736 cc 2025-04-15T21:28:15.710Z,1744752495.710 [DockingStepper](INFO): Stopping 2025-04-15T21:28:15.726Z,1744752495.726 [Reporter](INFO): platform_buoyancy_position 934.297852 cc 2025-04-15T21:28:16.046Z,1744752496.046 [DockingStepper](INFO): Stopping 2025-04-15T21:28:16.059Z,1744752496.059 [Reporter](INFO): platform_buoyancy_position 930.537476 cc 2025-04-15T21:28:16.350Z,1744752496.350 [DockingStepper](INFO): Stopping 2025-04-15T21:28:16.373Z,1744752496.373 [Reporter](INFO): platform_buoyancy_position 928.120117 cc 2025-04-15T21:28:16.909Z,1744752496.909 [DockingStepper](INFO): Stopping 2025-04-15T21:28:17.042Z,1744752497.042 [Reporter](INFO): platform_buoyancy_position 923.688232 cc 2025-04-15T21:28:17.356Z,1744752497.356 [DockingStepper](INFO): Stopping 2025-04-15T21:28:17.535Z,1744752497.535 [Reporter](INFO): platform_buoyancy_position 919.524902 cc 2025-04-15T21:28:17.841Z,1744752497.841 [DockingStepper](INFO): Stopping 2025-04-15T21:28:17.874Z,1744752497.874 [Reporter](INFO): platform_buoyancy_position 915.361572 cc 2025-04-15T21:28:18.201Z,1744752498.201 [DockingStepper](INFO): Stopping 2025-04-15T21:28:18.326Z,1744752498.326 [Reporter](INFO): platform_buoyancy_position 912.944214 cc 2025-04-15T21:28:18.727Z,1744752498.727 [DockingStepper](INFO): Stopping 2025-04-15T21:28:18.742Z,1744752498.742 [Reporter](INFO): platform_buoyancy_position 908.646606 cc 2025-04-15T21:28:19.205Z,1744752499.205 [DockingStepper](INFO): Stopping 2025-04-15T21:28:19.218Z,1744752499.218 [Reporter](INFO): platform_buoyancy_position 904.348999 cc 2025-04-15T21:28:19.442Z,1744752499.442 [DockingStepper](INFO): Stopping 2025-04-15T21:28:19.463Z,1744752499.463 [Reporter](INFO): platform_buoyancy_position 902.200195 cc 2025-04-15T21:28:20.022Z,1744752500.022 [DockingStepper](INFO): Stopping 2025-04-15T21:28:20.034Z,1744752500.034 [Reporter](INFO): platform_buoyancy_position 897.902588 cc 2025-04-15T21:28:20.358Z,1744752500.358 [DockingStepper](INFO): Stopping 2025-04-15T21:28:20.375Z,1744752500.375 [Reporter](INFO): platform_buoyancy_position 895.753784 cc 2025-04-15T21:28:20.789Z,1744752500.789 [DockingStepper](INFO): Stopping 2025-04-15T21:28:20.805Z,1744752500.805 [Reporter](INFO): platform_buoyancy_position 891.590454 cc 2025-04-15T21:28:21.269Z,1744752501.269 [DockingStepper](INFO): Stopping 2025-04-15T21:28:21.286Z,1744752501.286 [Reporter](INFO): platform_buoyancy_position 887.292847 cc 2025-04-15T21:28:21.573Z,1744752501.573 [DockingStepper](INFO): Stopping 2025-04-15T21:28:21.641Z,1744752501.641 [Reporter](INFO): platform_buoyancy_position 885.144043 cc 2025-04-15T21:28:22.087Z,1744752502.087 [DockingStepper](INFO): Stopping 2025-04-15T21:28:22.106Z,1744752502.106 [Reporter](INFO): platform_buoyancy_position 882.860962 cc 2025-04-15T21:28:22.445Z,1744752502.445 [DockingStepper](INFO): Stopping 2025-04-15T21:28:22.485Z,1744752502.485 [Reporter](INFO): platform_buoyancy_position 878.697632 cc 2025-04-15T21:28:22.997Z,1744752502.997 [DockingStepper](INFO): Stopping 2025-04-15T21:28:23.013Z,1744752503.013 [Reporter](INFO): platform_buoyancy_position 874.668701 cc 2025-04-15T21:28:23.335Z,1744752503.335 [DockingStepper](INFO): Stopping 2025-04-15T21:28:23.352Z,1744752503.352 [Reporter](INFO): platform_buoyancy_position 872.116943 cc 2025-04-15T21:28:23.817Z,1744752503.817 [DockingStepper](INFO): Stopping 2025-04-15T21:28:23.835Z,1744752503.835 [Reporter](INFO): platform_buoyancy_position 867.819336 cc 2025-04-15T21:28:24.210Z,1744752504.210 [DockingStepper](INFO): Stopping 2025-04-15T21:28:24.215Z,1744752504.215 [Reporter](INFO): platform_buoyancy_position 865.670532 cc 2025-04-15T21:28:24.458Z,1744752504.458 [DockingStepper](INFO): Stopping 2025-04-15T21:28:24.463Z,1744752504.463 [Reporter](INFO): platform_buoyancy_position 863.253174 cc 2025-04-15T21:28:25.021Z,1744752505.021 [DockingStepper](INFO): Stopping 2025-04-15T21:28:25.142Z,1744752505.142 [Reporter](INFO): platform_buoyancy_position 859.224121 cc 2025-04-15T21:28:25.442Z,1744752505.442 [DockingStepper](INFO): Stopping 2025-04-15T21:28:25.591Z,1744752505.591 [Reporter](INFO): platform_buoyancy_position 855.060913 cc 2025-04-15T21:28:25.989Z,1744752505.989 [DockingStepper](INFO): Stopping 2025-04-15T21:28:26.022Z,1744752506.022 [Reporter](INFO): platform_buoyancy_position 850.629028 cc 2025-04-15T21:28:26.286Z,1744752506.286 [DockingStepper](INFO): Stopping 2025-04-15T21:28:26.410Z,1744752506.410 [Reporter](INFO): platform_buoyancy_position 848.345825 cc 2025-04-15T21:28:26.573Z,1744752506.573 [DockingStepper](INFO): Stopping 2025-04-15T21:28:26.579Z,1744752506.579 [Reporter](INFO): platform_buoyancy_position 844.316895 cc 2025-04-15T21:28:27.014Z,1744752507.014 [DockingStepper](INFO): Stopping 2025-04-15T21:28:27.021Z,1744752507.021 [Reporter](INFO): platform_buoyancy_position 840.019287 cc 2025-04-15T21:28:27.334Z,1744752507.334 [DockingStepper](INFO): Stopping 2025-04-15T21:28:27.354Z,1744752507.354 [Reporter](INFO): platform_buoyancy_position 837.870483 cc 2025-04-15T21:28:27.968Z,1744752507.968 [DockingStepper](INFO): Stopping 2025-04-15T21:28:27.976Z,1744752507.976 [Reporter](INFO): platform_buoyancy_position 831.289795 cc 2025-04-15T21:28:28.229Z,1744752508.229 [DockingStepper](INFO): Stopping 2025-04-15T21:28:28.235Z,1744752508.235 [Reporter](INFO): platform_buoyancy_position 827.395020 cc 2025-04-15T21:28:28.529Z,1744752508.529 [DockingStepper](INFO): Stopping 2025-04-15T21:28:28.546Z,1744752508.546 [Reporter](INFO): platform_buoyancy_position 824.709106 cc 2025-04-15T21:28:29.125Z,1744752509.125 [DockingStepper](INFO): Stopping 2025-04-15T21:28:29.131Z,1744752509.131 [Reporter](INFO): platform_buoyancy_position 818.531250 cc 2025-04-15T21:28:29.457Z,1744752509.457 [DockingStepper](INFO): Stopping 2025-04-15T21:28:29.464Z,1744752509.464 [Reporter](INFO): platform_buoyancy_position 814.367981 cc 2025-04-15T21:28:29.950Z,1744752509.950 [DockingStepper](INFO): Stopping 2025-04-15T21:28:29.956Z,1744752509.956 [Reporter](INFO): platform_buoyancy_position 809.801758 cc 2025-04-15T21:28:30.257Z,1744752510.257 [DockingStepper](INFO): Stopping 2025-04-15T21:28:30.263Z,1744752510.263 [Reporter](INFO): platform_buoyancy_position 807.652954 cc 2025-04-15T21:28:30.569Z,1744752510.569 [DockingStepper](INFO): Stopping 2025-04-15T21:28:30.575Z,1744752510.575 [Reporter](INFO): platform_buoyancy_position 805.504150 cc 2025-04-15T21:28:30.977Z,1744752510.977 [DockingStepper](INFO): Stopping 2025-04-15T21:28:30.983Z,1744752510.983 [Reporter](INFO): platform_buoyancy_position 801.206543 cc 2025-04-15T21:28:31.339Z,1744752511.339 [DockingStepper](INFO): Stopping 2025-04-15T21:28:31.355Z,1744752511.355 [Reporter](INFO): platform_buoyancy_position 797.043274 cc 2025-04-15T21:28:31.957Z,1744752511.957 [DockingStepper](INFO): Stopping 2025-04-15T21:28:31.963Z,1744752511.963 [Reporter](INFO): platform_buoyancy_position 790.462585 cc 2025-04-15T21:28:32.298Z,1744752512.298 [DockingStepper](INFO): Stopping 2025-04-15T21:28:32.305Z,1744752512.305 [Reporter](INFO): platform_buoyancy_position 786.164978 cc 2025-04-15T21:28:32.587Z,1744752512.587 [DockingStepper](INFO): Stopping 2025-04-15T21:28:32.595Z,1744752512.595 [Reporter](INFO): platform_buoyancy_position 782.538879 cc 2025-04-15T21:28:33.003Z,1744752513.003 [NAL9602](INFO): SBD MO Status=2, MOMSN=47932, MT Status=2, MTMSN=0 2025-04-15T21:28:33.003Z,1744752513.003 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:28:33.281Z,1744752513.281 [DockingStepper](INFO): Stopped 2025-04-15T21:28:33.286Z,1744752513.286 [CBIT](INFO): Clearing failed state for component DockingStepper 2025-04-15T21:28:33.286Z,1744752513.286 [DockingStepper] No Fault, FailCount= 1 2025-04-15T21:28:33.288Z,1744752513.288 [Reporter](INFO): platform_buoyancy_position 777.704102 cc 2025-04-15T21:28:33.629Z,1744752513.629 [DockingStepper](INFO): Start 2025-04-15T21:28:33.630Z,1744752513.630 [DockingStepper](DEBUG): Initializing EZServoServo. 2025-04-15T21:28:33.630Z,1744752513.630 [DockingStepper](DEBUG): Initializing DockingStepper. 2025-04-15T21:28:33.781Z,1744752513.781 [Reporter](INFO): platform_buoyancy_position 773.406494 cc 2025-04-15T21:28:33.989Z,1744752513.989 [DockingStepper](INFO): Starting 2025-04-15T21:28:34.136Z,1744752514.136 [Reporter](INFO): platform_buoyancy_position 768.974548 cc 2025-04-15T21:28:34.317Z,1744752514.317 [DockingStepper](INFO): Starting 2025-04-15T21:28:34.372Z,1744752514.372 [Reporter](INFO): platform_buoyancy_position 766.691467 cc 2025-04-15T21:28:34.725Z,1744752514.725 [DockingStepper](INFO): Starting 2025-04-15T21:28:34.771Z,1744752514.771 [DockingStepper](INFO): Init string: /1z16319aE13561N3m50 2025-04-15T21:28:34.862Z,1744752514.862 [Reporter](INFO): platform_buoyancy_position 761.588074 cc 2025-04-15T21:28:35.151Z,1744752515.151 [DockingStepper](INFO): Starting 2025-04-15T21:28:35.274Z,1744752515.274 [Reporter](INFO): platform_buoyancy_position 756.216064 cc 2025-04-15T21:28:35.511Z,1744752515.511 [DockingStepper](INFO): Starting 2025-04-15T21:28:35.518Z,1744752515.518 [Reporter](INFO): platform_buoyancy_position 751.784180 cc 2025-04-15T21:28:35.970Z,1744752515.970 [DockingStepper](INFO): Starting 2025-04-15T21:28:35.975Z,1744752515.975 [Reporter](INFO): platform_buoyancy_position 745.472046 cc 2025-04-15T21:28:36.305Z,1744752516.305 [DockingStepper](INFO): Starting 2025-04-15T21:28:36.329Z,1744752516.329 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2025-04-15T21:28:36.338Z,1744752516.338 [Reporter](INFO): platform_buoyancy_position 741.040161 cc 2025-04-15T21:28:36.729Z,1744752516.729 [DockingStepper](INFO): Starting 2025-04-15T21:28:36.745Z,1744752516.745 [Reporter](INFO): platform_buoyancy_position 736.339661 cc 2025-04-15T21:28:37.190Z,1744752517.190 [DockingStepper](INFO): Changing to mode: 1 2025-04-15T21:28:37.190Z,1744752517.190 [DockingStepper](INFO): Standby mode. 2025-04-15T21:28:37.247Z,1744752517.247 [Reporter](INFO): platform_buoyancy_position 730.296143 cc 2025-04-15T21:28:37.606Z,1744752517.606 [Reporter](INFO): platform_buoyancy_position 725.998596 cc 2025-04-15T21:28:38.215Z,1744752518.215 [Reporter](INFO): platform_buoyancy_position 717.537659 cc 2025-04-15T21:28:38.523Z,1744752518.523 [Reporter](INFO): platform_buoyancy_position 715.254578 cc 2025-04-15T21:28:38.792Z,1744752518.792 [Reporter](INFO): platform_buoyancy_position 710.956970 cc 2025-04-15T21:28:39.215Z,1744752519.215 [Reporter](INFO): platform_buoyancy_position 706.659363 cc 2025-04-15T21:28:39.579Z,1744752519.579 [Reporter](INFO): platform_buoyancy_position 702.361755 cc 2025-04-15T21:28:40.047Z,1744752520.047 [Reporter](INFO): platform_buoyancy_position 695.915344 cc 2025-04-15T21:28:40.411Z,1744752520.411 [Reporter](INFO): platform_buoyancy_position 691.617737 cc 2025-04-15T21:28:40.832Z,1744752520.832 [Reporter](INFO): platform_buoyancy_position 687.320190 cc 2025-04-15T21:28:41.207Z,1744752521.207 [Reporter](INFO): platform_buoyancy_position 681.008057 cc 2025-04-15T21:28:41.497Z,1744752521.497 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:28:41.614Z,1744752521.614 [Reporter](INFO): platform_buoyancy_position 676.576172 cc 2025-04-15T21:28:42.247Z,1744752522.247 [Reporter](INFO): platform_buoyancy_position 669.458252 cc 2025-04-15T21:28:42.563Z,1744752522.563 [Reporter](INFO): platform_buoyancy_position 665.832153 cc 2025-04-15T21:28:42.827Z,1744752522.827 [Reporter](INFO): platform_buoyancy_position 661.668884 cc 2025-04-15T21:28:43.272Z,1744752523.272 [Reporter](INFO): platform_buoyancy_position 657.236938 cc 2025-04-15T21:28:43.727Z,1744752523.727 [Reporter](INFO): platform_buoyancy_position 651.730652 cc 2025-04-15T21:28:44.139Z,1744752524.139 [Reporter](INFO): platform_buoyancy_position 646.627258 cc 2025-04-15T21:28:44.503Z,1744752524.503 [Reporter](INFO): platform_buoyancy_position 642.195374 cc 2025-04-15T21:28:45.018Z,1744752525.018 [Reporter](INFO): platform_buoyancy_position 637.763489 cc 2025-04-15T21:28:45.459Z,1744752525.459 [Reporter](INFO): platform_buoyancy_position 631.451355 cc 2025-04-15T21:28:45.741Z,1744752525.741 [Reporter](INFO): platform_buoyancy_position 627.153748 cc 2025-04-15T21:28:46.234Z,1744752526.234 [Reporter](INFO): platform_buoyancy_position 620.707336 cc 2025-04-15T21:28:46.678Z,1744752526.678 [Reporter](INFO): platform_buoyancy_position 616.275452 cc 2025-04-15T21:28:46.912Z,1744752526.912 [Reporter](INFO): platform_buoyancy_position 610.097656 cc 2025-04-15T21:28:47.379Z,1744752527.379 [Reporter](INFO): platform_buoyancy_position 605.665771 cc 2025-04-15T21:28:47.657Z,1744752527.657 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2025-04-15T21:28:47.731Z,1744752527.731 [Reporter](INFO): platform_buoyancy_position 599.353638 cc 2025-04-15T21:28:48.127Z,1744752528.127 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, -5, +34, :BE, -5, +34, -10,A 2025-04-15T21:28:48.407Z,1744752528.407 [Reporter](INFO): platform_buoyancy_position 592.772949 cc 2025-04-15T21:28:48.746Z,1744752528.746 [Reporter](INFO): platform_buoyancy_position 588.475342 cc 2025-04-15T21:28:49.027Z,1744752529.027 [Reporter](INFO): platform_buoyancy_position 584.446350 cc 2025-04-15T21:28:49.574Z,1744752529.574 [Reporter](INFO): platform_buoyancy_position 579.880127 cc 2025-04-15T21:28:49.847Z,1744752529.847 [Reporter](INFO): platform_buoyancy_position 575.582581 cc 2025-04-15T21:28:50.255Z,1744752530.255 [Reporter](INFO): platform_buoyancy_position 571.284973 cc 2025-04-15T21:28:50.607Z,1744752530.607 [Reporter](INFO): platform_buoyancy_position 566.987366 cc 2025-04-15T21:28:51.147Z,1744752531.147 [Reporter](INFO): platform_buoyancy_position 560.406677 cc 2025-04-15T21:28:51.659Z,1744752531.659 [Reporter](INFO): platform_buoyancy_position 552.617249 cc 2025-04-15T21:28:52.060Z,1744752532.060 [Reporter](INFO): platform_buoyancy_position 547.782471 cc 2025-04-15T21:28:52.394Z,1744752532.394 [Reporter](INFO): platform_buoyancy_position 543.484863 cc 2025-04-15T21:28:52.710Z,1744752532.710 [Reporter](INFO): platform_buoyancy_position 539.052979 cc 2025-04-15T21:28:53.063Z,1744752533.063 [Reporter](INFO): platform_buoyancy_position 534.755371 cc 2025-04-15T21:28:53.467Z,1744752533.467 [Reporter](INFO): platform_buoyancy_position 529.249023 cc 2025-04-15T21:28:53.573Z,1744752533.573 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:28:53.834Z,1744752533.834 [Reporter](INFO): platform_buoyancy_position 524.145630 cc 2025-04-15T21:28:54.255Z,1744752534.255 [Reporter](INFO): platform_buoyancy_position 519.713745 cc 2025-04-15T21:28:54.648Z,1744752534.648 [Reporter](INFO): platform_buoyancy_position 513.401672 cc 2025-04-15T21:28:55.030Z,1744752535.030 [Reporter](INFO): platform_buoyancy_position 509.104065 cc 2025-04-15T21:28:55.483Z,1744752535.483 [Reporter](INFO): platform_buoyancy_position 502.657684 cc 2025-04-15T21:28:55.863Z,1744752535.863 [Reporter](INFO): platform_buoyancy_position 498.225800 cc 2025-04-15T21:28:56.359Z,1744752536.359 [Reporter](INFO): platform_buoyancy_position 491.779358 cc 2025-04-15T21:28:56.679Z,1744752536.679 [Reporter](INFO): platform_buoyancy_position 487.481750 cc 2025-04-15T21:28:57.115Z,1744752537.115 [Reporter](INFO): platform_buoyancy_position 481.303955 cc 2025-04-15T21:28:57.551Z,1744752537.551 [Reporter](INFO): platform_buoyancy_position 476.737732 cc 2025-04-15T21:28:57.904Z,1744752537.904 [Reporter](INFO): platform_buoyancy_position 470.425659 cc 2025-04-15T21:28:58.391Z,1744752538.391 [Reporter](INFO): platform_buoyancy_position 464.113525 cc 2025-04-15T21:28:58.710Z,1744752538.710 [Reporter](INFO): platform_buoyancy_position 459.815918 cc 2025-04-15T21:28:59.131Z,1744752539.131 [Reporter](INFO): platform_buoyancy_position 455.384033 cc 2025-04-15T21:28:59.607Z,1744752539.607 [Reporter](INFO): platform_buoyancy_position 448.803345 cc 2025-04-15T21:28:59.946Z,1744752539.946 [Reporter](INFO): platform_buoyancy_position 444.505737 cc 2025-04-15T21:29:00.387Z,1744752540.387 [Reporter](INFO): platform_buoyancy_position 438.327942 cc 2025-04-15T21:29:00.741Z,1744752540.741 [Reporter](INFO): platform_buoyancy_position 434.433228 cc 2025-04-15T21:29:01.183Z,1744752541.183 [Reporter](INFO): platform_buoyancy_position 427.449646 cc 2025-04-15T21:29:01.577Z,1744752541.577 [Reporter](INFO): platform_buoyancy_position 423.152039 cc 2025-04-15T21:29:01.927Z,1744752541.927 [Reporter](INFO): platform_buoyancy_position 418.720154 cc 2025-04-15T21:29:02.366Z,1744752542.366 [Reporter](INFO): platform_buoyancy_position 412.542358 cc 2025-04-15T21:29:02.715Z,1744752542.715 [Reporter](INFO): platform_buoyancy_position 407.976135 cc 2025-04-15T21:29:03.199Z,1744752543.200 [Reporter](INFO): platform_buoyancy_position 401.664062 cc 2025-04-15T21:29:03.596Z,1744752543.596 [Reporter](INFO): platform_buoyancy_position 397.232117 cc 2025-04-15T21:29:03.929Z,1744752543.929 [Reporter](INFO): platform_buoyancy_position 390.920044 cc 2025-04-15T21:29:04.313Z,1744752544.313 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:29:04.391Z,1744752544.391 [Reporter](INFO): platform_buoyancy_position 386.085266 cc 2025-04-15T21:29:04.776Z,1744752544.776 [Reporter](INFO): platform_buoyancy_position 380.847534 cc 2025-04-15T21:29:05.201Z,1744752545.201 [Reporter](INFO): platform_buoyancy_position 375.878418 cc 2025-04-15T21:29:05.572Z,1744752545.572 [Reporter](INFO): platform_buoyancy_position 371.446533 cc 2025-04-15T21:29:05.943Z,1744752545.943 [Reporter](INFO): platform_buoyancy_position 365.134460 cc 2025-04-15T21:29:06.414Z,1744752546.414 [Reporter](INFO): platform_buoyancy_position 358.688049 cc 2025-04-15T21:29:06.795Z,1744752546.795 [Reporter](INFO): platform_buoyancy_position 354.390442 cc 2025-04-15T21:29:07.214Z,1744752547.214 [Reporter](INFO): platform_buoyancy_position 350.092834 cc 2025-04-15T21:29:07.635Z,1744752547.635 [Reporter](INFO): platform_buoyancy_position 343.646423 cc 2025-04-15T21:29:08.030Z,1744752548.030 [Reporter](INFO): platform_buoyancy_position 339.214539 cc 2025-04-15T21:29:08.539Z,1744752548.539 [Reporter](INFO): platform_buoyancy_position 330.753662 cc 2025-04-15T21:29:08.942Z,1744752548.942 [Reporter](INFO): platform_buoyancy_position 328.336243 cc 2025-04-15T21:29:09.346Z,1744752549.346 [Reporter](INFO): platform_buoyancy_position 322.158447 cc 2025-04-15T21:29:09.712Z,1744752549.712 [Reporter](INFO): platform_buoyancy_position 317.726562 cc 2025-04-15T21:29:10.158Z,1744752550.158 [Reporter](INFO): platform_buoyancy_position 311.280151 cc 2025-04-15T21:29:10.546Z,1744752550.546 [Reporter](INFO): platform_buoyancy_position 304.968048 cc 2025-04-15T21:29:10.824Z,1744752550.824 [Reporter](INFO): platform_buoyancy_position 300.670441 cc 2025-04-15T21:29:11.253Z,1744752551.253 [Reporter](INFO): platform_buoyancy_position 296.238525 cc 2025-04-15T21:29:11.794Z,1744752551.794 [Reporter](INFO): platform_buoyancy_position 289.926422 cc 2025-04-15T21:29:12.150Z,1744752552.150 [Reporter](INFO): platform_buoyancy_position 285.628845 cc 2025-04-15T21:29:12.506Z,1744752552.506 [Reporter](INFO): platform_buoyancy_position 279.316742 cc 2025-04-15T21:29:12.997Z,1744752552.997 [Reporter](INFO): platform_buoyancy_position 274.884827 cc 2025-04-15T21:29:13.231Z,1744752553.231 [Reporter](INFO): platform_buoyancy_position 270.587250 cc 2025-04-15T21:29:13.500Z,1744752553.500 [NAL9602](INFO): SBD MO Status=2, MOMSN=47932, MT Status=2, MTMSN=0 2025-04-15T21:29:13.500Z,1744752553.500 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:29:13.688Z,1744752553.688 [Reporter](INFO): platform_buoyancy_position 264.140839 cc 2025-04-15T21:29:14.051Z,1744752554.051 [Reporter](INFO): platform_buoyancy_position 259.843231 cc 2025-04-15T21:29:14.479Z,1744752554.479 [Reporter](INFO): platform_buoyancy_position 253.396805 cc 2025-04-15T21:29:14.773Z,1744752554.773 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:29:14.967Z,1744752554.967 [Reporter](INFO): platform_buoyancy_position 248.964935 cc 2025-04-15T21:29:15.396Z,1744752555.396 [Reporter](INFO): platform_buoyancy_position 244.667313 cc 2025-04-15T21:29:15.706Z,1744752555.706 [Reporter](INFO): platform_buoyancy_position 238.220947 cc 2025-04-15T21:29:16.189Z,1744752556.189 [Reporter](INFO): platform_buoyancy_position 232.177429 cc 2025-04-15T21:29:16.567Z,1744752556.567 [Reporter](INFO): platform_buoyancy_position 227.476929 cc 2025-04-15T21:29:17.046Z,1744752557.046 [Reporter](INFO): platform_buoyancy_position 221.164825 cc 2025-04-15T21:29:17.306Z,1744752557.306 [Reporter](INFO): platform_buoyancy_position 216.732941 cc 2025-04-15T21:29:17.739Z,1744752557.739 [Reporter](INFO): platform_buoyancy_position 210.420837 cc 2025-04-15T21:29:18.169Z,1744752558.169 [Reporter](INFO): platform_buoyancy_position 205.988922 cc 2025-04-15T21:29:18.601Z,1744752558.601 [Reporter](INFO): platform_buoyancy_position 199.676819 cc 2025-04-15T21:29:18.970Z,1744752558.970 [Reporter](INFO): platform_buoyancy_position 195.379242 cc 2025-04-15T21:29:19.331Z,1744752559.331 [Reporter](INFO): platform_buoyancy_position 188.932831 cc 2025-04-15T21:29:19.858Z,1744752559.858 [Reporter](INFO): platform_buoyancy_position 184.635223 cc 2025-04-15T21:29:20.262Z,1744752560.262 [Reporter](INFO): platform_buoyancy_position 180.203339 cc 2025-04-15T21:29:20.631Z,1744752560.631 [Reporter](INFO): platform_buoyancy_position 173.756927 cc 2025-04-15T21:29:21.183Z,1744752561.183 [Reporter](INFO): platform_buoyancy_position 167.310516 cc 2025-04-15T21:29:21.481Z,1744752561.481 [Reporter](INFO): platform_buoyancy_position 161.401337 cc 2025-04-15T21:29:21.849Z,1744752561.849 [Reporter](INFO): platform_buoyancy_position 157.506622 cc 2025-04-15T21:29:22.289Z,1744752562.289 [Reporter](INFO): platform_buoyancy_position 152.403229 cc 2025-04-15T21:29:22.684Z,1744752562.684 [Reporter](INFO): platform_buoyancy_position 145.956818 cc 2025-04-15T21:29:22.941Z,1744752562.941 [Reporter](INFO): platform_buoyancy_position 143.673737 cc 2025-04-15T21:29:23.377Z,1744752563.377 [Reporter](INFO): platform_buoyancy_position 137.227325 cc 2025-04-15T21:29:23.914Z,1744752563.914 [Reporter](INFO): platform_buoyancy_position 131.049530 cc 2025-04-15T21:29:24.294Z,1744752564.294 [Reporter](INFO): platform_buoyancy_position 126.617615 cc 2025-04-15T21:29:24.678Z,1744752564.678 [Reporter](INFO): platform_buoyancy_position 120.305511 cc 2025-04-15T21:29:25.090Z,1744752565.090 [Reporter](INFO): platform_buoyancy_position 115.873627 cc 2025-04-15T21:29:25.381Z,1744752565.381 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:29:25.397Z,1744752565.397 [Reporter](INFO): platform_buoyancy_position 111.441711 cc 2025-04-15T21:29:25.815Z,1744752565.815 [Reporter](INFO): platform_buoyancy_position 104.995331 cc 2025-04-15T21:29:26.183Z,1744752566.183 [Reporter](INFO): platform_buoyancy_position 100.697723 cc 2025-04-15T21:29:26.778Z,1744752566.778 [Reporter](INFO): platform_buoyancy_position 94.385620 cc 2025-04-15T21:29:27.158Z,1744752567.158 [Reporter](INFO): platform_buoyancy_position 90.088013 cc 2025-04-15T21:29:27.438Z,1744752567.438 [Reporter](INFO): platform_buoyancy_position 85.387512 cc 2025-04-15T21:29:28.002Z,1744752568.002 [Reporter](INFO): platform_buoyancy_position 79.209717 cc 2025-04-15T21:29:35.485Z,1744752575.485 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:29:45.649Z,1744752585.649 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:29:47.645Z,1744752587.645 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2025-04-15T21:29:55.893Z,1744752595.893 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:29:59.195Z,1744752599.195 [NAL9602](INFO): SBD MO Status=2, MOMSN=47932, MT Status=2, MTMSN=0 2025-04-15T21:29:59.195Z,1744752599.195 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2025-04-15T21:30:03.239Z,1744752603.239 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS,251, +18.9, 0.0,1518.4, 0 2025-04-15T21:30:05.981Z,1744752605.981 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:30:08.282Z,1744752608.282 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-3278,-32768,V 2025-04-15T21:30:21.773Z,1744752621.773 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:30:32.017Z,1744752632.017 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:30:42.109Z,1744752642.109 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:30:49.349Z,1744752649.349 [Reporter](INFO): platform_buoyancy_position 72.494720 cc 2025-04-15T21:30:49.686Z,1744752649.686 [Reporter](INFO): platform_buoyancy_position 72.763306 cc 2025-04-15T21:30:50.782Z,1744752650.782 [Reporter](INFO): platform_buoyancy_position 79.209717 cc 2025-04-15T21:30:51.181Z,1744752651.181 [Reporter](INFO): platform_buoyancy_position 84.581726 cc 2025-04-15T21:30:51.584Z,1744752651.584 [Reporter](INFO): platform_buoyancy_position 89.953735 cc 2025-04-15T21:30:52.126Z,1744752652.126 [Reporter](INFO): platform_buoyancy_position 96.400116 cc 2025-04-15T21:30:52.531Z,1744752652.531 [Reporter](INFO): platform_buoyancy_position 100.832031 cc 2025-04-15T21:30:52.850Z,1744752652.850 [Reporter](INFO): platform_buoyancy_position 107.144135 cc 2025-04-15T21:30:53.262Z,1744752653.262 [Reporter](INFO): platform_buoyancy_position 111.844635 cc 2025-04-15T21:30:53.767Z,1744752653.767 [Reporter](INFO): platform_buoyancy_position 117.888123 cc 2025-04-15T21:30:54.187Z,1744752654.187 [Reporter](INFO): platform_buoyancy_position 122.320038 cc 2025-04-15T21:30:54.542Z,1744752654.542 [Reporter](INFO): platform_buoyancy_position 126.483337 cc 2025-04-15T21:30:54.887Z,1744752654.887 [Reporter](INFO): platform_buoyancy_position 130.512329 cc 2025-04-15T21:30:55.324Z,1744752655.324 [Reporter](INFO): platform_buoyancy_position 135.078522 cc 2025-04-15T21:30:55.731Z,1744752655.731 [Reporter](INFO): platform_buoyancy_position 137.227325 cc 2025-04-15T21:30:56.282Z,1744752656.282 [Reporter](INFO): platform_buoyancy_position 139.779022 cc 2025-04-15T21:30:56.664Z,1744752656.664 [Reporter](INFO): platform_buoyancy_position 143.673737 cc 2025-04-15T21:30:56.975Z,1744752656.975 [Reporter](INFO): platform_buoyancy_position 145.822540 cc 2025-04-15T21:30:57.274Z,1744752657.274 [Reporter](INFO): platform_buoyancy_position 147.971313 cc 2025-04-15T21:30:57.900Z,1744752657.900 [Reporter](INFO): platform_buoyancy_position 152.134613 cc 2025-04-15T21:30:58.227Z,1744752658.227 [Reporter](INFO): platform_buoyancy_position 154.552032 cc 2025-04-15T21:30:58.595Z,1744752658.595 [Reporter](INFO): platform_buoyancy_position 158.715332 cc 2025-04-15T21:30:59.008Z,1744752659.008 [Reporter](INFO): platform_buoyancy_position 160.998413 cc 2025-04-15T21:30:59.428Z,1744752659.428 [Reporter](INFO): platform_buoyancy_position 163.012939 cc 2025-04-15T21:31:04.410Z,1744752664.410 [Reporter](INFO): platform_buoyancy_position 169.593628 cc 2025-04-15T21:31:04.954Z,1744752664.954 [Reporter](INFO): platform_buoyancy_position 169.459320 cc 2025-04-15T21:31:05.475Z,1744752665.475 [Reporter](INFO): platform_buoyancy_position 163.147217 cc 2025-04-15T21:31:05.999Z,1744752665.999 [Reporter](INFO): platform_buoyancy_position 158.983917 cc 2025-04-15T21:31:06.451Z,1744752666.451 [Reporter](INFO): platform_buoyancy_position 156.566528 cc 2025-04-15T21:31:06.735Z,1744752666.735 [Reporter](INFO): platform_buoyancy_position 152.806122 cc 2025-04-15T21:31:07.064Z,1744752667.064 [Reporter](INFO): platform_buoyancy_position 150.254425 cc 2025-04-15T21:31:07.682Z,1744752667.682 [Reporter](INFO): platform_buoyancy_position 145.956818 cc 2025-04-15T21:31:13.497Z,1744752673.497 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:31:17.235Z,1744752677.235 [Reporter](INFO): platform_buoyancy_position 139.510437 cc 2025-04-15T21:31:18.047Z,1744752678.047 [Reporter](INFO): platform_buoyancy_position 141.524933 cc 2025-04-15T21:31:18.491Z,1744752678.491 [Reporter](INFO): platform_buoyancy_position 143.808014 cc 2025-04-15T21:31:18.851Z,1744752678.851 [Reporter](INFO): platform_buoyancy_position 145.822540 cc 2025-04-15T21:31:19.297Z,1744752679.297 [Reporter](INFO): platform_buoyancy_position 148.239929 cc 2025-04-15T21:31:19.689Z,1744752679.689 [Reporter](INFO): platform_buoyancy_position 152.268921 cc 2025-04-15T21:31:20.063Z,1744752680.063 [Reporter](INFO): platform_buoyancy_position 154.417725 cc 2025-04-15T21:31:28.397Z,1744752688.397 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 105.18, 84.04, 89.2:BI, +21, +13, +5, +4,A 2025-04-15T21:31:39.659Z,1744752699.659 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS, -18, +3,A 2025-04-15T21:31:41.610Z,1744752701.610 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.504044 2025-04-15T21:31:42.613Z,1744752702.613 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:31:50.385Z,1744752710.385 [Reporter](INFO): platform_buoyancy_position 158.983917 cc 2025-04-15T21:32:02.911Z,1744752722.911 [Reporter](INFO): platform_buoyancy_position 156.835114 cc 2025-04-15T21:32:12.737Z,1744752732.737 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:32:13.741Z,1744752733.741 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:32:24.330Z,1744752744.330 [Reporter](INFO): platform_buoyancy_position 158.715332 cc 2025-04-15T21:32:43.869Z,1744752763.869 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:32:44.873Z,1744752764.873 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:32:55.432Z,1744752775.432 [Reporter](INFO): platform_buoyancy_position 158.849640 cc 2025-04-15T21:33:08.527Z,1744752788.527 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-04-15T21:33:15.001Z,1744752795.001 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:33:16.005Z,1744752796.005 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:33:31.488Z,1744752811.488 [Reporter](INFO): platform_buoyancy_position 156.969421 cc 2025-04-15T21:33:35.473Z,1744752815.473 [Reporter](INFO): platform_buoyancy_position 156.566528 cc 2025-04-15T21:33:39.244Z,1744752819.244 [NAL9602](INFO): Not Powering down - fast GPS 2025-04-15T21:33:39.903Z,1744752819.903 [Reporter](INFO): platform_buoyancy_position 154.820618 cc 2025-04-15T21:33:40.175Z,1744752820.175 [Reporter](INFO): platform_buoyancy_position 156.566528 cc 2025-04-15T21:33:46.125Z,1744752826.125 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:33:47.129Z,1744752827.129 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:34:11.031Z,1744752851.031 [Reporter](INFO): platform_buoyancy_position 150.254425 cc 2025-04-15T21:34:17.277Z,1744752857.277 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:34:18.281Z,1744752858.281 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:34:48.356Z,1744752888.356 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for beam range. Device response is::RA, 0.00, 100.03, 93.32, 90.23 2025-04-15T21:34:48.409Z,1744752888.409 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:34:49.413Z,1744752889.413 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:34:50.631Z,1744752890.631 [Reporter](INFO): platform_buoyancy_position 149.985840 cc 2025-04-15T21:34:55.004Z,1744752895.004 [Reporter](INFO): platform_buoyancy_position 147.971313 cc 2025-04-15T21:34:55.287Z,1744752895.287 [Reporter](INFO): platform_buoyancy_position 148.105621 cc 2025-04-15T21:34:59.837Z,1744752899.837 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2025-04-15T21:35:00.147Z,1744752900.147 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/OnDock.tl 2025-04-15T21:35:00.147Z,1744752900.147 [MissionManager](INFO): Uninitializing Mission sink 2025-04-15T21:35:00.147Z,1744752900.147 [sink] Stopped 2025-04-15T21:35:00.147Z,1744752900.147 [sink](DEBUG): Aggregate::uninitialize sink 2025-04-15T21:35:00.147Z,1744752900.147 [sink:Science] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science](DEBUG): Aggregate::uninitialize sink:Science 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science:B] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science:C] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science:E] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science:F] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science:OceanCurrent] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sink:Science:OceanCurrent 2025-04-15T21:35:00.148Z,1744752900.148 [sink:Science:OceanCurrent:A.] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:StandardEnvelopes] Stopped 2025-04-15T21:35:00.148Z,1744752900.148 [sink:StandardEnvelopes](DEBUG): Aggregate::uninitialize sink:StandardEnvelopes 2025-04-15T21:35:00.148Z,1744752900.148 [sink:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2025-04-15T21:35:00.149Z,1744752900.149 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2025-04-15T21:35:00.149Z,1744752900.149 [sink:StandardEnvelopes:B.DepthEnvelope] Stopped 2025-04-15T21:35:00.149Z,1744752900.149 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2025-04-15T21:35:00.149Z,1744752900.149 [sink:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2025-04-15T21:35:00.149Z,1744752900.149 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2025-04-15T21:35:00.149Z,1744752900.149 [sink:BackseatDriver] Stopped 2025-04-15T21:35:00.149Z,1744752900.149 [sink:BackseatDriver](DEBUG): Aggregate::uninitialize sink:BackseatDriver 2025-04-15T21:35:00.149Z,1744752900.149 [sink:BackseatDriver:A.BackseatDriver] Stopped 2025-04-15T21:35:00.149Z,1744752900.149 [sink:PowerOnly] Stopped 2025-04-15T21:35:00.149Z,1744752900.149 [sink:PowerOnly](DEBUG): Aggregate::uninitialize sink:PowerOnly 2025-04-15T21:35:00.149Z,1744752900.149 [sink:PowerOnly:E.Wait] Stopped 2025-04-15T21:35:00.149Z,1744752900.149 [sink:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink](DEBUG): Aggregate::uninitialize sink:RunSink 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:A] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:B] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:C] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:D] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:E] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Stopped 2025-04-15T21:35:00.150Z,1744752900.150 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Uninitialize. 2025-04-15T21:35:00.151Z,1744752900.151 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Stopped 2025-04-15T21:35:00.151Z,1744752900.151 [sink:RunSink:JustSink] Stopped 2025-04-15T21:35:00.151Z,1744752900.151 [sink:RunSink:JustSink](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink 2025-04-15T21:35:00.151Z,1744752900.151 [sink:RunSink:JustSink:C] Stopped 2025-04-15T21:35:00.151Z,1744752900.151 [sink:RunSink:JustSink:C](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink:C 2025-04-15T21:35:00.289Z,1744752900.289 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/OnDock.tl 2025-04-15T21:35:00.289Z,1744752900.289 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/OnDock.tl 2025-04-15T21:35:00.291Z,1744752900.291 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/OnDock.tl 2025-04-15T21:35:00.466Z,1744752900.466 [WetLabsBB2FL](INFO): Powering down 2025-04-15T21:35:00.953Z,1744752900.953 [WetLabsUBAT](INFO): Powering down 2025-04-15T21:35:01.114Z,1744752901.114 [Reporter](INFO): platform_buoyancy_position 141.524933 cc 2025-04-15T21:35:01.357Z,1744752901.357 [Reporter](INFO): platform_buoyancy_position 141.659210 cc 2025-04-15T21:35:01.770Z,1744752901.770 [Reporter](INFO): platform_buoyancy_position 143.808014 cc 2025-04-15T21:35:02.288Z,1744752902.288 [Reporter](INFO): platform_buoyancy_position 145.956818 cc 2025-04-15T21:35:02.766Z,1744752902.766 [Reporter](INFO): platform_buoyancy_position 150.120117 cc 2025-04-15T21:35:03.058Z,1744752903.058 [Reporter](INFO): platform_buoyancy_position 156.566528 cc 2025-04-15T21:35:03.430Z,1744752903.430 [Reporter](INFO): platform_buoyancy_position 160.998413 cc 2025-04-15T21:35:03.632Z,1744752903.632 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/OnDock.tl translated into: 8 2 1 5 2 2 5 5 Restarting logs restart logs ! ifconfig Mission ending, breaking off. Range: . 2025-04-15T21:35:03.687Z,1744752903.687 [MissionManager](INFO): DefineArg OnDock.DockedTime = 8.000000 h 2025-04-15T21:35:03.700Z,1744752903.700 [MissionManager](INFO): DefineArg OnDock.DetachedTimeout = 30.000000 s 2025-04-15T21:35:03.764Z,1744752903.764 [MissionManager](INFO): DefineArg OnDock.RangeTimeout = 600.000000 s 2025-04-15T21:35:03.768Z,1744752903.768 [MissionManager](INFO): DefineArg OnDock.TrackingUpdatePeriod = 2.000000 min 2025-04-15T21:35:03.784Z,1744752903.784 [MissionManager](INFO): DefineArg OnDock.NumberOfPings = 1.000000 count 2025-04-15T21:35:03.811Z,1744752903.811 [MissionManager](INFO): DefineArg OnDock.TransponderCode = 50 count 2025-04-15T21:35:03.839Z,1744752903.839 [MissionManager](INFO): DefineArg OnDock.MaxDepth = 215.000000 m 2025-04-15T21:35:03.873Z,1744752903.873 [MissionManager](INFO): DefineArg OnDock.MinAltitude = 5.000000 m 2025-04-15T21:35:03.886Z,1744752903.886 [MissionManager](INFO): DefineArg OnDock.MinOffshore = 2.000000 km 2025-04-15T21:35:03.914Z,1744752903.914 [Reporter](INFO): platform_buoyancy_position 167.444824 cc 2025-04-15T21:35:03.915Z,1744752903.915 [MissionManager](INFO): DefineArg OnDock.StayOnDock = 0 bool 2025-04-15T21:35:03.935Z,1744752903.935 [MissionManager](INFO): DefineArg OnDock.IfconfigInterval = 2.000000 h 2025-04-15T21:35:03.943Z,1744752903.943 [MissionManager](INFO): DefineArg OnDock.RunScience = 0 bool 2025-04-15T21:35:03.971Z,1744752903.971 [MissionManager](INFO): DefineArg OnDock.MissionTimeout = 8.000000 h 2025-04-15T21:35:03.971Z,1744752903.971 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:35:03.971Z,1744752903.971 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:35:03.981Z,1744752903.981 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2025-04-15T21:35:04.262Z,1744752904.262 [Reporter](INFO): platform_buoyancy_position 171.876740 cc 2025-04-15T21:35:04.293Z,1744752904.293 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2025-04-15T21:35:04.303Z,1744752904.303 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinAltitude = 5.000000 m 2025-04-15T21:35:04.307Z,1744752904.307 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2025-04-15T21:35:04.319Z,1744752904.319 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepth = 200.000000 m 2025-04-15T21:35:04.323Z,1744752904.323 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinOffshore = 2000.000000 m 2025-04-15T21:35:04.324Z,1744752904.324 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2025-04-15T21:35:04.349Z,1744752904.349 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2025-04-15T21:35:04.385Z,1744752904.385 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2025-04-15T21:35:04.420Z,1744752904.420 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2025-04-15T21:35:04.420Z,1744752904.420 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2025-04-15T21:35:04.469Z,1744752904.469 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2025-04-15T21:35:04.583Z,1744752904.583 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2025-04-15T21:35:04.600Z,1744752904.600 [MissionManager](INFO): DefineArg OnDock:BackseatDriver.EnableBackseat = 0 bool 2025-04-15T21:35:04.613Z,1744752904.613 [OnDock:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2025-04-15T21:35:04.616Z,1744752904.616 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2025-04-15T21:35:04.616Z,1744752904.616 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2025-04-15T21:35:04.621Z,1744752904.621 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2025-04-15T21:35:04.690Z,1744752904.690 [Reporter](INFO): platform_buoyancy_position 178.188843 cc 2025-04-15T21:35:04.896Z,1744752904.896 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2025-04-15T21:35:04.921Z,1744752904.921 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleAll = 0 bool 2025-04-15T21:35:04.937Z,1744752904.937 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad1 = 0 bool 2025-04-15T21:35:04.945Z,1744752904.945 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad2 = 0 bool 2025-04-15T21:35:04.973Z,1744752904.973 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad3 = 0 bool 2025-04-15T21:35:04.997Z,1744752904.997 [MissionManager](INFO): DefineArg OnDock:PowerOnly.EnabledPowerOnly = 0 bool 2025-04-15T21:35:05.022Z,1744752905.022 [OnDock:PowerOnly:E.Wait](DEBUG): Construct Wait. 2025-04-15T21:35:05.032Z,1744752905.032 [OnDock:dataRead:B.Wait](DEBUG): Construct Wait. 2025-04-15T21:35:05.038Z,1744752905.038 [Reporter](INFO): platform_buoyancy_position 182.486420 cc 2025-04-15T21:35:05.042Z,1744752905.042 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl 2025-04-15T21:35:05.043Z,1744752905.043 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl 2025-04-15T21:35:05.050Z,1744752905.050 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl 2025-04-15T21:35:05.415Z,1744752905.415 [Reporter](INFO): platform_buoyancy_position 186.784027 cc 2025-04-15T21:35:05.846Z,1744752905.846 [Reporter](INFO): platform_buoyancy_position 192.558929 cc 2025-04-15T21:35:06.326Z,1744752906.326 [Reporter](INFO): platform_buoyancy_position 197.393738 cc 2025-04-15T21:35:06.603Z,1744752906.603 [Reporter](INFO): platform_buoyancy_position 201.825623 cc 2025-04-15T21:35:07.055Z,1744752907.055 [Reporter](INFO): platform_buoyancy_position 208.137726 cc 2025-04-15T21:35:07.426Z,1744752907.426 [Reporter](INFO): platform_buoyancy_position 212.569641 cc 2025-04-15T21:35:07.500Z,1744752907.500 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into: NaN 3 100 80 20 5 NaN NaN 2.0 NaN NaN 5 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 _.planktivore_LM_AvgRois _.planktivore_HM_AvgRois _.planktivore_diatoms _.planktivore_dinoflagellates Triggered. PeakChl values on consecutive yo-yo profiles fall in [ ] (NaN bound is ignored). 2025-04-15T21:35:07.547Z,1744752907.547 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectChlActive = 0 bool 2025-04-15T21:35:07.557Z,1744752907.557 [MissionManager](INFO): DefineArg OnDock:science:Science.TimeWindowPeakReport = nan min 2025-04-15T21:35:07.586Z,1744752907.586 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestChlPeakReportActive = 0 bool 2025-04-15T21:35:07.596Z,1744752907.596 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestSaltPeakReportActive = 0 bool 2025-04-15T21:35:07.612Z,1744752907.612 [MissionManager](INFO): DefineArg OnDock:science:Science.HighestOilPeakReportActive = 0 bool 2025-04-15T21:35:07.619Z,1744752907.619 [MissionManager](INFO): DefineArg OnDock:science:Science.PatchTracking = 0 bool 2025-04-15T21:35:07.623Z,1744752907.623 [MissionManager](INFO): DefineArg OnDock:science:Science.FilterWidthHorizontal = 3.000000 count 2025-04-15T21:35:07.643Z,1744752907.643 [MissionManager](INFO): DefineArg OnDock:science:Science.NumProfilesSlidingwindow = 100.000000 count 2025-04-15T21:35:07.655Z,1744752907.655 [MissionManager](INFO): DefineArg OnDock:science:Science.OffPeakFractionHorizontal = 80.000000 % 2025-04-15T21:35:07.659Z,1744752907.659 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectNO3Active = 0 bool 2025-04-15T21:35:07.730Z,1744752907.730 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectOilActive = 0 bool 2025-04-15T21:35:07.742Z,1744752907.742 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectFDOMActive = 0 bool 2025-04-15T21:35:07.761Z,1744752907.761 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectSalinityActive = 0 bool 2025-04-15T21:35:07.777Z,1744752907.777 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool 2025-04-15T21:35:07.805Z,1744752907.805 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool 2025-04-15T21:35:07.814Z,1744752907.814 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool 2025-04-15T21:35:07.831Z,1744752907.831 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool 2025-04-15T21:35:07.843Z,1744752907.843 [MissionManager](INFO): DefineArg OnDock:science:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2025-04-15T21:35:07.855Z,1744752907.855 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledAanderaaO2 = 0 bool 2025-04-15T21:35:07.860Z,1744752907.860 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledNeilBrown = 0 bool 2025-04-15T21:35:07.885Z,1744752907.885 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledSeabird = 1 bool 2025-04-15T21:35:07.895Z,1744752907.895 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsBB2FL = 1 bool 2025-04-15T21:35:07.931Z,1744752907.931 [Reporter](INFO): platform_buoyancy_position 219.016022 cc 2025-04-15T21:35:07.940Z,1744752907.940 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2025-04-15T21:35:07.949Z,1744752907.949 [MissionManager](INFO): DefineArg OnDock:science:Science.EnabledWetLabsUBAT = 1 bool 2025-04-15T21:35:07.957Z,1744752907.957 [MissionManager](INFO): DefineArg OnDock:science:Science.LowPassWindowLength = 20.000000 count 2025-04-15T21:35:07.969Z,1744752907.969 [MissionManager](INFO): DefineArg OnDock:science:Science.MedianFilterLen = 5.000000 count 2025-04-15T21:35:07.975Z,1744752907.975 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakShallowBound = nan m 2025-04-15T21:35:07.979Z,1744752907.979 [MissionManager](INFO): DefineArg OnDock:science:Science.PeakDeepBound = nan m 2025-04-15T21:35:07.983Z,1744752907.983 [MissionManager](INFO): DefineArg OnDock:science:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2025-04-15T21:35:07.994Z,1744752907.994 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlThreshTriggerActive = 0 bool 2025-04-15T21:35:07.999Z,1744752907.999 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlLowerThresh = nan ug/l 2025-04-15T21:35:08.018Z,1744752908.018 [MissionManager](INFO): DefineArg OnDock:science:Science.ChlUpperThresh = nan ug/l 2025-04-15T21:35:08.022Z,1744752908.022 [MissionManager](INFO): DefineArg OnDock:science:Science.NumProfilesThresh = 5.000000 count 2025-04-15T21:35:08.034Z,1744752908.034 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChl = nan ug/l 2025-04-15T21:35:08.039Z,1744752908.039 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlDepth = nan m 2025-04-15T21:35:08.051Z,1744752908.051 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlTemperature = nan degC 2025-04-15T21:35:08.059Z,1744752908.059 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlLatitude = nan arcdeg 2025-04-15T21:35:08.063Z,1744752908.063 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakChlLongitude = nan arcdeg 2025-04-15T21:35:08.107Z,1744752908.107 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3 = nan umol/l 2025-04-15T21:35:08.112Z,1744752908.112 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Depth = nan m 2025-04-15T21:35:08.128Z,1744752908.128 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Latitude = nan arcdeg 2025-04-15T21:35:08.155Z,1744752908.155 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakNO3Longitude = nan arcdeg 2025-04-15T21:35:08.167Z,1744752908.167 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOil = nan kg/m3 2025-04-15T21:35:08.172Z,1744752908.172 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilDepth = nan m 2025-04-15T21:35:08.189Z,1744752908.189 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilLatitude = nan arcdeg 2025-04-15T21:35:08.196Z,1744752908.196 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakOilLongitude = nan arcdeg 2025-04-15T21:35:08.200Z,1744752908.200 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOM = nan ppb 2025-04-15T21:35:08.219Z,1744752908.219 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMDepth = nan m 2025-04-15T21:35:08.229Z,1744752908.229 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMTemperature = nan degC 2025-04-15T21:35:08.239Z,1744752908.239 [Reporter](INFO): platform_buoyancy_position 223.313629 cc 2025-04-15T21:35:08.241Z,1744752908.241 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMLatitude = nan arcdeg 2025-04-15T21:35:08.249Z,1744752908.249 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakFDOMLongitude = nan arcdeg 2025-04-15T21:35:08.257Z,1744752908.257 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSalt = nan psu 2025-04-15T21:35:08.269Z,1744752908.269 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltDepth = nan m 2025-04-15T21:35:08.290Z,1744752908.290 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltTemperature = nan degC 2025-04-15T21:35:08.312Z,1744752908.312 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltLatitude = nan arcdeg 2025-04-15T21:35:08.320Z,1744752908.320 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakSaltLongitude = nan arcdeg 2025-04-15T21:35:08.328Z,1744752908.328 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROI = nan count/s 2025-04-15T21:35:08.344Z,1744752908.344 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROIDepth = nan m 2025-04-15T21:35:08.361Z,1744752908.361 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROITemperature = nan degC 2025-04-15T21:35:08.367Z,1744752908.367 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg 2025-04-15T21:35:08.379Z,1744752908.379 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg 2025-04-15T21:35:08.391Z,1744752908.391 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROI = nan count/s 2025-04-15T21:35:08.399Z,1744752908.399 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROIDepth = nan m 2025-04-15T21:35:08.404Z,1744752908.404 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROITemperature = nan degC 2025-04-15T21:35:08.424Z,1744752908.424 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg 2025-04-15T21:35:08.432Z,1744752908.432 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg 2025-04-15T21:35:08.449Z,1744752908.449 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatoms = nan count/ml 2025-04-15T21:35:08.455Z,1744752908.455 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsDepth = nan m 2025-04-15T21:35:08.459Z,1744752908.459 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsTemperature = nan degC 2025-04-15T21:35:08.467Z,1744752908.467 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg 2025-04-15T21:35:08.515Z,1744752908.515 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg 2025-04-15T21:35:08.546Z,1744752908.546 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellates = nan count/ml 2025-04-15T21:35:08.554Z,1744752908.554 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesDepth = nan m 2025-04-15T21:35:08.581Z,1744752908.581 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC 2025-04-15T21:35:08.620Z,1744752908.620 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg 2025-04-15T21:35:08.640Z,1744752908.640 [MissionManager](INFO): DefineOutput OnDock:science:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg 2025-04-15T21:35:08.683Z,1744752908.683 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChl = nan ug/l 2025-04-15T21:35:08.695Z,1744752908.695 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlDepth = nan m 2025-04-15T21:35:08.707Z,1744752908.707 [Reporter](INFO): platform_buoyancy_position 229.894318 cc 2025-04-15T21:35:08.715Z,1744752908.715 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlLatitude = nan arcdeg 2025-04-15T21:35:08.727Z,1744752908.727 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlLongitude = nan arcdeg 2025-04-15T21:35:08.731Z,1744752908.731 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchChlDistance = nan m 2025-04-15T21:35:08.741Z,1744752908.741 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSalt = nan psu 2025-04-15T21:35:08.748Z,1744752908.748 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltDepth = nan m 2025-04-15T21:35:08.756Z,1744752908.756 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltLatitude = nan arcdeg 2025-04-15T21:35:08.776Z,1744752908.776 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltLongitude = nan arcdeg 2025-04-15T21:35:08.788Z,1744752908.788 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchSaltDistance = nan m 2025-04-15T21:35:08.808Z,1744752908.808 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOil = nan psu 2025-04-15T21:35:08.816Z,1744752908.816 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilDepth = nan m 2025-04-15T21:35:08.828Z,1744752908.828 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilLatitude = nan arcdeg 2025-04-15T21:35:08.836Z,1744752908.836 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilLongitude = nan arcdeg 2025-04-15T21:35:08.848Z,1744752908.848 [MissionManager](INFO): DefineOutput OnDock:science:Science.PatchOilDistance = nan m 2025-04-15T21:35:08.873Z,1744752908.873 [MissionManager](INFO): DefineOutput OnDock:science:Science.TriggeredOnChl = 0 bool 2025-04-15T21:35:08.923Z,1744752908.923 [MissionManager](INFO): DefineOutput OnDock:science:Science.ChlTriggering = nan ug/l 2025-04-15T21:35:09.017Z,1744752909.017 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.070Z,1744752909.070 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:35:09.111Z,1744752909.111 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.149Z,1744752909.149 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.159Z,1744752909.159 [Reporter](INFO): platform_buoyancy_position 236.072144 cc 2025-04-15T21:35:09.172Z,1744752909.172 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:35:09.215Z,1744752909.215 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.240Z,1744752909.240 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.355Z,1744752909.355 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2025-04-15T21:35:09.442Z,1744752909.442 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.491Z,1744752909.491 [Reporter](INFO): platform_buoyancy_position 240.369720 cc 2025-04-15T21:35:09.492Z,1744752909.492 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.554Z,1744752909.554 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.638Z,1744752909.638 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2025-04-15T21:35:09.663Z,1744752909.663 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect. 2025-04-15T21:35:09.851Z,1744752909.851 [Reporter](INFO): platform_buoyancy_position 244.801636 cc 2025-04-15T21:35:09.935Z,1744752909.935 [OnDock:L.Execute](DEBUG): Construct Execute. 2025-04-15T21:35:09.951Z,1744752909.951 [OnDock:PeriodicCheck:CheckIP:A.Execute](DEBUG): Construct Execute. 2025-04-15T21:35:09.957Z,1744752909.957 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Construct Wait. 2025-04-15T21:35:09.959Z,1744752909.959 [OnDock:N.Docked](DEBUG): Construct. 2025-04-15T21:35:09.959Z,1744752909.959 [OnDock:N.Docked](DEBUG): Initializing internal variables to default values. 2025-04-15T21:35:10.033Z,1744752910.033 [OnDock:Detach:B.Undock](DEBUG): Construct. 2025-04-15T21:35:10.033Z,1744752910.033 [OnDock:Detach:B.Undock](DEBUG): Initializing internal variables to default values. 2025-04-15T21:35:10.207Z,1744752910.207 [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 { """ Wait on dock, communicating when possible """ arguments { DockedTime = 8 hour """ Time to stay on dock. Mission timeout will be five minutes longer. """ DetachedTimeout = Dock:Docked.detachTimeout """ Time duration limit for determining if the vehicle is detached from the dock. """ RangeTimeout = Dock:Docked.rangeTimeout """ Maximum allowed time without acoustic range. """ TrackingUpdatePeriod = 2 minute """ How long to wait between acoustic queries. """ NumberOfPings = 1 count """ Number of pings requested each time. """ TransponderCode = Dock:Dock.transponderCode """ Transponder Address. """ MaxDepth = BIT:CBIT.stopDepth """ Maximum depth while docked. """ MinAltitude = 5 meter """ Minimum altitude """ MinOffshore = 2 km """ Minimum offshore """ StayOnDock = false """ If true, don't detach from dock at end of mission """ IfconfigInterval = 2 hour """ How long to wait between ifconfig runs """ RunScience = false """ If true, run Science while on the dock. """ # Mission variables (do not change) MissionTimeout = DockedTime """ Mission timeout (local variable, do not change) """ } timeout duration=MissionTimeout insert Insert/StandardEnvelopes.tl assign in sequence StandardEnvelopes:MinAltitude = MinAltitude assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore # End docking 5 minutes before end of mission to allow clean undock assign in sequence MissionTimeout = DockedTime + 5 minute insert Insert/BackseatDriver.tl insert Insert/PowerOnly.tl # Send data when connection exists aggregate dataRead { run while ( true ) readDatum { Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } } aggregate science { run in parallel break if ( not RunScience ) insert Insert/Science.tl } behavior Estimation:TrackAcousticContact { run in parallel set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } syslog important "Restarting logs" behavior Guidance:Execute { run in sequence set command = "restart logs" } aggregate PeriodicCheck { run in parallel aggregate CheckIP { run in sequence behavior Guidance:Execute { run in sequence set command = "! ifconfig" } behavior Guidance:Wait { run in sequence set duration = IfconfigInterval } } } behavior Dock:Docked { run in sequence timeout duration=DockedTime set detachTimeout = DetachedTimeout set rangeTimeout = RangeTimeout } # Undock cleanly, instead of relying on DefaultWithUndock to come next aggregate Detach { run in sequence break if ( StayOnDock == true ) syslog important "Mission ending, breaking off. Range: " + Estimation:TrackAcousticContact.range_to_contact~meter + "." behavior Dock:Undock { run in sequence } } } 2025-04-15T21:35:10.207Z,1744752910.207 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/OnDock.tl id=OnDock 2025-04-15T21:35:10.262Z,1744752910.262 [Reporter](INFO): platform_buoyancy_position 251.113724 cc 2025-04-15T21:35:10.586Z,1744752910.586 [MissionManager](IMPORTANT): Started mission DefaultTankUndock 2025-04-15T21:35:10.586Z,1744752910.586 [DefaultTankUndock] Running Loop=1 2025-04-15T21:35:10.586Z,1744752910.586 [DefaultTankUndock](DEBUG): Aggregate::initialize DefaultTankUndock 2025-04-15T21:35:10.586Z,1744752910.586 [DefaultTankUndock:B.GoToSurface] Running Loop=1 2025-04-15T21:35:10.586Z,1744752910.586 [DefaultTankUndock:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-04-15T21:35:10.588Z,1744752910.588 [DefaultTankUndock:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-04-15T21:35:10.598Z,1744752910.598 [DefaultTankUndock:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-04-15T21:35:10.599Z,1744752910.599 [DefaultTankUndock:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-04-15T21:35:10.600Z,1744752910.600 [DefaultTankUndock:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-04-15T21:35:10.622Z,1744752910.622 [DefaultTankUndock:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-04-15T21:35:10.623Z,1744752910.623 [DefaultTankUndock:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-04-15T21:35:10.623Z,1744752910.623 [DefaultTankUndock:A.Wait] Running Loop=1 2025-04-15T21:35:10.624Z,1744752910.624 [DefaultTankUndock:A.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:35:10.743Z,1744752910.743 [Reporter](INFO): platform_buoyancy_position 257.560120 cc 2025-04-15T21:35:11.078Z,1744752911.078 [Reporter](INFO): platform_buoyancy_position 261.992035 cc 2025-04-15T21:35:11.431Z,1744752911.431 [Reporter](INFO): platform_buoyancy_position 266.289642 cc 2025-04-15T21:35:12.050Z,1744752912.050 [Reporter](INFO): platform_buoyancy_position 272.601746 cc 2025-04-15T21:35:12.302Z,1744752912.302 [Reporter](INFO): platform_buoyancy_position 277.033630 cc 2025-04-15T21:35:12.715Z,1744752912.715 [Reporter](INFO): platform_buoyancy_position 281.599823 cc 2025-04-15T21:35:13.230Z,1744752913.230 [Reporter](INFO): platform_buoyancy_position 287.643341 cc 2025-04-15T21:35:13.586Z,1744752913.586 [Reporter](INFO): platform_buoyancy_position 292.075226 cc 2025-04-15T21:35:13.896Z,1744752913.896 [Reporter](INFO): platform_buoyancy_position 298.387329 cc 2025-04-15T21:35:14.290Z,1744752914.290 [Reporter](INFO): platform_buoyancy_position 302.684937 cc 2025-04-15T21:35:14.713Z,1744752914.713 [Reporter](INFO): platform_buoyancy_position 309.265625 cc 2025-04-15T21:35:15.123Z,1744752915.123 [Reporter](INFO): platform_buoyancy_position 314.637634 cc 2025-04-15T21:35:15.495Z,1744752915.495 [Reporter](INFO): platform_buoyancy_position 319.606750 cc 2025-04-15T21:35:15.918Z,1744752915.918 [Reporter](INFO): platform_buoyancy_position 324.307251 cc 2025-04-15T21:35:16.311Z,1744752916.311 [Reporter](INFO): platform_buoyancy_position 329.276367 cc 2025-04-15T21:35:16.709Z,1744752916.709 [Reporter](INFO): platform_buoyancy_position 334.916931 cc 2025-04-15T21:35:17.156Z,1744752917.156 [Reporter](INFO): platform_buoyancy_position 341.497620 cc 2025-04-15T21:35:17.530Z,1744752917.530 [Reporter](INFO): platform_buoyancy_position 345.660950 cc 2025-04-15T21:35:17.892Z,1744752917.892 [CommandExec](IMPORTANT): got command set OnDock.DockedTime .5 hour 2025-04-15T21:35:17.917Z,1744752917.917 [CommandExec](IMPORTANT): got command set OnDock.MinAltitude 0.1 meter 2025-04-15T21:35:17.918Z,1744752917.918 [CommandExec](IMPORTANT): got command set OnDock.MinOffshore 0.0001 kilometer 2025-04-15T21:35:17.918Z,1744752917.918 [CommandExec](IMPORTANT): got command run 2025-04-15T21:35:17.926Z,1744752917.926 [CommandExec](IMPORTANT): Running 2025-04-15T21:35:17.967Z,1744752917.967 [Reporter](INFO): platform_buoyancy_position 352.107361 cc 2025-04-15T21:35:18.214Z,1744752918.214 [DefaultTankUndock] Stopped 2025-04-15T21:35:18.214Z,1744752918.214 [DefaultTankUndock](DEBUG): Aggregate::uninitialize DefaultTankUndock 2025-04-15T21:35:18.214Z,1744752918.214 [DefaultTankUndock:A.Wait] Stopped 2025-04-15T21:35:18.215Z,1744752918.215 [DefaultTankUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2025-04-15T21:35:18.215Z,1744752918.215 [DefaultTankUndock:B.GoToSurface] Stopped 2025-04-15T21:35:18.215Z,1744752918.215 [DefaultTankUndock:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-04-15T21:35:18.215Z,1744752918.215 [MissionManager](IMPORTANT): Started mission OnDock 2025-04-15T21:35:18.215Z,1744752918.215 [OnDock] Running Loop=1 2025-04-15T21:35:18.215Z,1744752918.215 [OnDock](DEBUG): Aggregate::initialize OnDock 2025-04-15T21:35:18.215Z,1744752918.215 [OnDock:StandardEnvelopes] Running Loop=1 2025-04-15T21:35:18.215Z,1744752918.215 [OnDock:StandardEnvelopes](DEBUG): Aggregate::initialize OnDock:StandardEnvelopes 2025-04-15T21:35:18.215Z,1744752918.215 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-04-15T21:35:18.216Z,1744752918.216 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2025-04-15T21:35:18.216Z,1744752918.216 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-04-15T21:35:18.216Z,1744752918.216 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2025-04-15T21:35:18.216Z,1744752918.216 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-04-15T21:35:18.216Z,1744752918.216 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2025-04-15T21:35:18.216Z,1744752918.216 [OnDock:BackseatDriver] Running Loop=1 2025-04-15T21:35:18.216Z,1744752918.216 [OnDock:BackseatDriver](DEBUG): Aggregate::initialize OnDock:BackseatDriver 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:BackseatDriver:A.BackseatDriver] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly](DEBUG): Aggregate::initialize OnDock:PowerOnly 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly:A] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly:B] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly:C] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly:D] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly:E.Wait] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:dataRead] Running Loop=1 2025-04-15T21:35:18.217Z,1744752918.217 [OnDock:dataRead](DEBUG): Aggregate::initialize OnDock:dataRead 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:dataRead:A] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science](DEBUG): Aggregate::initialize OnDock:science 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science](DEBUG): Aggregate::initialize OnDock:science:Science 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:A] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:B] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:C] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:D] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:E] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:F] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:Read_Oil] Running Loop=1 2025-04-15T21:35:18.218Z,1744752918.218 [OnDock:science:Science:PeakDetectChl] Running Loop=1 2025-04-15T21:35:18.219Z,1744752918.219 [OnDock:science:Science:PeakDetectChl](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectChl 2025-04-15T21:35:18.219Z,1744752918.219 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.219Z,1744752918.219 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.221Z,1744752918.221 [OnDock:science:Science:HighestChlPeakReport] Running Loop=1 2025-04-15T21:35:18.221Z,1744752918.221 [OnDock:science:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestChlPeakReport 2025-04-15T21:35:18.221Z,1744752918.221 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:35:18.221Z,1744752918.221 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:35:18.222Z,1744752918.222 [OnDock:science:Science:PeakDetectNO3] Running Loop=1 2025-04-15T21:35:18.222Z,1744752918.222 [OnDock:science:Science:PeakDetectNO3](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectNO3 2025-04-15T21:35:18.222Z,1744752918.222 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.222Z,1744752918.222 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.224Z,1744752918.224 [OnDock:science:Science:PeakDetectOil] Running Loop=1 2025-04-15T21:35:18.224Z,1744752918.224 [OnDock:science:Science:PeakDetectOil](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectOil 2025-04-15T21:35:18.225Z,1744752918.225 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.225Z,1744752918.225 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.227Z,1744752918.227 [OnDock:science:Science:HighestOilPeakReport] Running Loop=1 2025-04-15T21:35:18.227Z,1744752918.227 [OnDock:science:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestOilPeakReport 2025-04-15T21:35:18.227Z,1744752918.227 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:35:18.227Z,1744752918.227 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:35:18.227Z,1744752918.227 [OnDock:science:Science:PeakDetectFDOM] Running Loop=1 2025-04-15T21:35:18.228Z,1744752918.228 [OnDock:science:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectFDOM 2025-04-15T21:35:18.228Z,1744752918.228 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.228Z,1744752918.228 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.229Z,1744752918.229 [OnDock:science:Science:PeakDetectSalinity] Running Loop=1 2025-04-15T21:35:18.230Z,1744752918.230 [OnDock:science:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectSalinity 2025-04-15T21:35:18.230Z,1744752918.230 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.230Z,1744752918.230 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.231Z,1744752918.231 [OnDock:science:Science:HighestSaltPeakReport] Running Loop=1 2025-04-15T21:35:18.231Z,1744752918.231 [OnDock:science:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize OnDock:science:Science:HighestSaltPeakReport 2025-04-15T21:35:18.232Z,1744752918.232 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2025-04-15T21:35:18.232Z,1744752918.232 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2025-04-15T21:35:18.232Z,1744752918.232 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1 2025-04-15T21:35:18.232Z,1744752918.232 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreLMavgROI 2025-04-15T21:35:18.233Z,1744752918.233 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.233Z,1744752918.233 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.233Z,1744752918.233 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_LM_AvgRois , but backseat URI detected. Waiting for presence. 2025-04-15T21:35:18.234Z,1744752918.234 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1 2025-04-15T21:35:18.234Z,1744752918.234 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreHMavgROI 2025-04-15T21:35:18.234Z,1744752918.234 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.234Z,1744752918.234 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.235Z,1744752918.235 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_HM_AvgRois , but backseat URI detected. Waiting for presence. 2025-04-15T21:35:18.235Z,1744752918.235 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1 2025-04-15T21:35:18.236Z,1744752918.236 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreDiatoms 2025-04-15T21:35:18.236Z,1744752918.236 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.236Z,1744752918.236 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.237Z,1744752918.237 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_diatoms , but backseat URI detected. Waiting for presence. 2025-04-15T21:35:18.238Z,1744752918.238 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1 2025-04-15T21:35:18.238Z,1744752918.238 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates 2025-04-15T21:35:18.238Z,1744752918.238 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Running Loop=1 2025-04-15T21:35:18.238Z,1744752918.238 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Initialize. 2025-04-15T21:35:18.238Z,1744752918.238 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](INFO): No ElementURI called _.planktivore_dinoflagellates , but backseat URI detected. Waiting for presence. 2025-04-15T21:35:18.239Z,1744752918.239 [OnDock:science:Science:ChlThreshTrigger] Running Loop=1 2025-04-15T21:35:18.239Z,1744752918.239 [OnDock:science:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize OnDock:science:Science:ChlThreshTrigger 2025-04-15T21:35:18.240Z,1744752918.240 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1 2025-04-15T21:35:18.240Z,1744752918.240 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize. 2025-04-15T21:35:18.240Z,1744752918.240 [OnDock:science:Science:OceanCurrent] Running Loop=1 2025-04-15T21:35:18.240Z,1744752918.240 [OnDock:science:Science:OceanCurrent](DEBUG): Aggregate::initialize OnDock:science:Science:OceanCurrent 2025-04-15T21:35:18.240Z,1744752918.240 [OnDock:science:Science:OceanCurrent:A.] Running Loop=1 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:science:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:J.] Running Loop=1 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:J.](INFO): Initializing TrackAcousticContact. 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:PeriodicCheck] Running Loop=1 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:PeriodicCheck](DEBUG): Aggregate::initialize OnDock:PeriodicCheck 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:PeriodicCheck:CheckIP] Running Loop=1 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::initialize OnDock:PeriodicCheck:CheckIP 2025-04-15T21:35:18.241Z,1744752918.241 [OnDock:PeriodicCheck:CheckIP:A.Execute] Running Loop=1 2025-04-15T21:35:18.242Z,1744752918.242 [OnDock:B] Running Loop=1 2025-04-15T21:35:18.242Z,1744752918.242 [OnDock:PeriodicCheck] Running Loop=1 2025-04-15T21:35:18.242Z,1744752918.242 [OnDock:PeriodicCheck:CheckIP:A.Execute](INFO): Executing command ! ifconfig 2025-04-15T21:35:18.242Z,1744752918.242 [OnDock:PeriodicCheck:CheckIP:A.Execute] Stopped 2025-04-15T21:35:18.242Z,1744752918.242 [OnDock:PeriodicCheck:CheckIP:B.Wait] Running Loop=1 2025-04-15T21:35:18.243Z,1744752918.243 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Initialize Wait Component. 2025-04-15T21:35:18.243Z,1744752918.243 [OnDock:J.] Running Loop=1 2025-04-15T21:35:18.243Z,1744752918.243 [OnDock:science] Stopped 2025-04-15T21:35:18.243Z,1744752918.243 [OnDock:science](DEBUG): Aggregate::uninitialize OnDock:science 2025-04-15T21:35:18.243Z,1744752918.243 [OnDock:science:Science] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science](DEBUG): Aggregate::uninitialize OnDock:science:Science 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:A] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:B] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:C] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:D] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:E] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:F] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:Read_Oil] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:OceanCurrent] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:OceanCurrent](DEBUG): Aggregate::uninitialize OnDock:science:Science:OceanCurrent 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:OceanCurrent:A.] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:PeakDetectChl] Stopped 2025-04-15T21:35:18.244Z,1744752918.244 [OnDock:science:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectChl 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:HighestChlPeakReport] Stopped 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestChlPeakReport 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectNO3] Stopped 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectNO3 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectOil] Stopped 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectOil 2025-04-15T21:35:18.245Z,1744752918.245 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:HighestOilPeakReport] Stopped 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestOilPeakReport 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectFDOM] Stopped 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectFDOM 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectSalinity] Stopped 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectSalinity 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.246Z,1744752918.246 [OnDock:science:Science:HighestSaltPeakReport] Stopped 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize OnDock:science:Science:HighestSaltPeakReport 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI] Stopped 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreLMavgROI 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreLMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI] Stopped 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreHMavgROI 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreHMavgROI:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.247Z,1744752918.247 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms] Stopped 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreDiatoms 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:PeakDetectPlanktivoreDiatoms:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates] Stopped 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth] Stopped 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:PeakDetectPlanktivoreDinoflagellates:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:ChlThreshTrigger] Stopped 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize OnDock:science:Science:ChlThreshTrigger 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect] Stopped 2025-04-15T21:35:18.248Z,1744752918.248 [OnDock:science:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize. 2025-04-15T21:35:18.249Z,1744752918.249 [OnDock:dataRead] Running Loop=1 2025-04-15T21:35:18.249Z,1744752918.249 [OnDock:dataRead:A](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-04-15T21:35:18.250Z,1744752918.250 [OnDock:PowerOnly] Running Loop=1 2025-04-15T21:35:18.250Z,1744752918.250 [OnDock:PowerOnly:D] Stopped 2025-04-15T21:35:18.250Z,1744752918.250 [OnDock:PowerOnly:C] Stopped 2025-04-15T21:35:18.250Z,1744752918.250 [OnDock:PowerOnly:B] Stopped 2025-04-15T21:35:18.250Z,1744752918.250 [OnDock:PowerOnly:A] Stopped 2025-04-15T21:35:18.250Z,1744752918.250 [OnDock:BackseatDriver] Running Loop=1 2025-04-15T21:35:18.251Z,1744752918.251 [OnDock:B] Stopped 2025-04-15T21:35:18.251Z,1744752918.251 [OnDock:C] Running Loop=1 2025-04-15T21:35:18.251Z,1744752918.251 [OnDock:StandardEnvelopes] Running Loop=1 2025-04-15T21:35:18.251Z,1744752918.251 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2025-04-15T21:35:18.251Z,1744752918.251 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE 2025-04-15T21:35:18.315Z,1744752918.315 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2025-04-15T21:35:18.315Z,1744752918.315 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2025-04-15T21:35:18.342Z,1744752918.342 [CommandExec](IMPORTANT): got command ! ifconfig 2025-04-15T21:35:18.534Z,1744752918.534 [Reporter](INFO): platform_buoyancy_position 356.539246 cc 2025-04-15T21:35:18.697Z,1744752918.697 [CommandExec](IMPORTANT): eth0 Link encap:Ethernet HWaddr 50:2D:F4:07:45:4B inet addr:10.89.10.2 Bcast:10.89.255.255 Mask:255.255.0.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:1070760 errors:0 dropped:0 overruns:0 frame:0 TX packets:1329576 errors:0 dropped:0 overruns:0 carrier:0 collisions:20898 txqueuelen:1000 RX bytes:389678936 (371.6 Mb) TX bytes:761943067 (726.6 Mb) Interrupt:29 lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MULTICAST MTU:16436 Metric:1 RX packets:402 errors:0 dropped:0 overruns:0 frame:0 TX packets:402 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:38896 (37.9 Kb) TX bytes:38896 (37.9 Kb) 2025-04-15T21:35:19.183Z,1744752919.183 [OnDock:C] Stopped 2025-04-15T21:35:19.184Z,1744752919.184 [OnDock:D] Running Loop=1 2025-04-15T21:35:19.422Z,1744752919.422 [Reporter](INFO): platform_buoyancy_position 365.134460 cc 2025-04-15T21:35:19.533Z,1744752919.533 [OnDock:D] Stopped 2025-04-15T21:35:19.534Z,1744752919.534 [OnDock:E] Running Loop=1 2025-04-15T21:35:19.542Z,1744752919.542 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2025-04-15T21:35:19.697Z,1744752919.697 [Reporter](INFO): platform_buoyancy_position 367.283264 cc 2025-04-15T21:35:19.967Z,1744752919.967 [OnDock:E] Stopped 2025-04-15T21:35:19.967Z,1744752919.967 [OnDock:K] Running Loop=1 2025-04-15T21:35:20.314Z,1744752920.314 [Reporter](INFO): platform_buoyancy_position 369.566345 cc 2025-04-15T21:35:20.545Z,1744752920.545 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2025-04-15T21:35:22.342Z,1744752922.342 [OnDock:K](IMPORTANT): Restarting logs 2025-04-15T21:35:22.342Z,1744752922.342 [OnDock:K] Stopped 2025-04-15T21:35:22.342Z,1744752922.342 [OnDock:L.Execute] Running Loop=1 2025-04-15T21:35:22.582Z,1744752922.582 [Reporter](INFO): platform_buoyancy_position 397.366455 cc