2025-04-22T16:33:01.016Z,1745339581.016 [CommandExec](IMPORTANT): got command restart logs
2025-04-22T16:33:14.248Z,1745339594.248 [NAL9602](INFO): Powering up NAL9602
2025-04-22T16:33:25.156Z,1745339605.156 [NAL9602](INFO): NAL9602 initialized
2025-04-22T16:36:45.989Z,1745339805.989 [CommandExec](IMPORTANT): got command schedule
2025-04-22T16:36:45.990Z,1745339805.990 [CommandExec](FAULT): Scheduling was paused by a command at 2025-04-22T14:29:13Z
2025-04-22T16:36:54.221Z,1745339814.221 [CommandExec](IMPORTANT): got command schedule clear
2025-04-22T16:36:54.221Z,1745339814.221 [CommandExec](IMPORTANT): Cleared 0 scheduled commands.
2025-04-22T16:36:54.222Z,1745339814.222 [CommandExec](IMPORTANT): got command schedule resume
2025-04-22T16:36:54.222Z,1745339814.222 [CommandExec](IMPORTANT): Scheduling is resumed
2025-04-22T16:37:42.166Z,1745339862.166 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-04-22T16:32:41.0Z
2025-04-22T16:37:42.166Z,1745339862.166 [Default:CheckIn:Read_GPS] Stopped
2025-04-22T16:37:42.167Z,1745339862.167 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-22T16:37:50.996Z,1745339870.996 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250422T012554/Courier0160.lzma
2025-04-22T16:37:51.998Z,1745339871.998 [DataOverHttps](INFO): Moved sent file to Logs/20250422T012554/Courier0160.lzma.bak
2025-04-22T16:37:51.998Z,1745339871.998 [DataOverHttps](INFO): SBD MOMSN=24710290
2025-04-22T16:38:10.634Z,1745339890.634 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250422T163301/Courier0000.lzma
2025-04-22T16:38:11.635Z,1745339891.635 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Courier0000.lzma.bak
2025-04-22T16:38:11.635Z,1745339891.635 [DataOverHttps](INFO): SBD MOMSN=24710299
2025-04-22T16:38:30.830Z,1745339910.830 [DataOverHttps](INFO): Sending 492 bytes from file Logs/20250422T012554/Express0161.lzma
2025-04-22T16:38:31.830Z,1745339911.830 [DataOverHttps](INFO): Moved sent file to Logs/20250422T012554/Express0161.lzma.bak
2025-04-22T16:38:31.830Z,1745339911.830 [DataOverHttps](INFO): SBD MOMSN=24710308
2025-04-22T16:38:44.662Z,1745339924.662 [NAL9602](INFO): SBD MO Status=2, MOMSN=8274, MT Status=2, MTMSN=0
2025-04-22T16:38:44.662Z,1745339924.662 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-04-22T16:38:45.044Z,1745339925.044 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-22T16:38:51.225Z,1745339931.225 [DataOverHttps](INFO): Sending 423 bytes from file Logs/20250422T163301/Express0001.lzma
2025-04-22T16:38:52.220Z,1745339932.220 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0001.lzma.bak
2025-04-22T16:38:52.221Z,1745339932.221 [DataOverHttps](INFO): SBD MOMSN=24710333
2025-04-22T16:39:11.872Z,1745339951.872 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250422T163301/Express0004.lzma
2025-04-22T16:39:12.875Z,1745339952.875 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0004.lzma.bak
2025-04-22T16:39:12.875Z,1745339952.875 [DataOverHttps](INFO): SBD MOMSN=24710342
2025-04-22T16:39:14.202Z,1745339954.202 [Default:CheckIn:Read_Iridium] Stopped
2025-04-22T16:39:14.203Z,1745339954.203 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-22T16:39:14.203Z,1745339954.203 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-22T16:39:15.752Z,1745339955.752 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-22T16:39:31.593Z,1745339971.593 [Waterlinked](INFO): Powering down
2025-04-22T16:40:32.658Z,1745340032.658 [DataOverHttps](IMPORTANT): SBD MTMSN=20250422T164031
2025-04-22T16:40:40.609Z,1745340040.609 [DataOverHttps](INFO): Received command: sched 20250422T17 "gfisolate"
2025-04-22T16:40:40.660Z,1745340040.660 [CommandExec](IMPORTANT): got command schedule 20250422T170000 "gfisolate"
2025-04-22T16:40:40.660Z,1745340040.660 [CommandExec](IMPORTANT): Scheduled #1: "gfisolate", AT TIME: 2025-04-22T17:00:00Z
2025-04-22T16:40:41.610Z,1745340041.610 [DataOverHttps](IMPORTANT): SBD MTMSN=20250422T164040
2025-04-22T16:40:43.200Z,1745340043.200 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position
2025-04-22T16:40:43.444Z,1745340043.444 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2025-04-22T16:40:49.377Z,1745340049.377 [DataOverHttps](INFO): Received command: load Engineering/sink.tl;set sink.SinkDuration 0.6 h;set sink.TargetDepthTimeout 12 h;set sink.MinAltitude 0.00001 m;set sink.MinOffshore 0.0001 km;run
2025-04-22T16:40:49.484Z,1745340049.484 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/sink.tl
2025-04-22T16:40:49.484Z,1745340049.484 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/sink.tl
2025-04-22T16:40:49.489Z,1745340049.489 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/sink.tl
2025-04-22T16:40:49.491Z,1745340049.491 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/sink.tl
2025-04-22T16:40:54.019Z,1745340054.019 [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-22T16:40:54.025Z,1745340054.025 [MissionManager](INFO): DefineArg sink.SinkDuration = 2.000000 h
2025-04-22T16:40:54.027Z,1745340054.027 [MissionManager](INFO): DefineArg sink.WaitToFloat = 20.000000 min
2025-04-22T16:40:54.029Z,1745340054.029 [MissionManager](INFO): DefineArg sink.Depth = 20.000000 m
2025-04-22T16:40:54.031Z,1745340054.031 [MissionManager](INFO): DefineArg sink.DepthDeadband = 1.000000 m
2025-04-22T16:40:54.034Z,1745340054.034 [MissionManager](INFO): DefineArg sink.SurfaceThreshold = 2.500000 m
2025-04-22T16:40:54.036Z,1745340054.036 [MissionManager](INFO): DefineArg sink.TargetDepthTimeout = 20.000000 min
2025-04-22T16:40:54.038Z,1745340054.038 [MissionManager](INFO): DefineArg sink.DoBallastAndTrim = 0 bool
2025-04-22T16:40:54.040Z,1745340054.040 [MissionManager](INFO): DefineArg sink.BTSettleTime = 10.000000 min
2025-04-22T16:40:54.042Z,1745340054.042 [MissionManager](INFO): DefineArg sink.EstimationTimeout = 45.000000 min
2025-04-22T16:40:54.044Z,1745340054.044 [MissionManager](INFO): DefineArg sink.MinEstimationTime = 10.000000 min
2025-04-22T16:40:54.046Z,1745340054.046 [MissionManager](INFO): DefineArg sink.MassEstimationErrorBound = 0.500000 mm
2025-04-22T16:40:54.049Z,1745340054.049 [MissionManager](INFO): DefineArg sink.BuoyEstimationErrorBound = 25.000000 cc
2025-04-22T16:40:54.051Z,1745340054.051 [MissionManager](INFO): DefineArg sink.EstimationConfidence = 98.000000 %
2025-04-22T16:40:54.104Z,1745340054.104 [MissionManager](INFO): DefineArg sink.MinAltitude = 5.000000 m
2025-04-22T16:40:54.106Z,1745340054.106 [MissionManager](INFO): DefineArg sink.MaxDepth = 30.000000 m
2025-04-22T16:40:54.118Z,1745340054.118 [MissionManager](INFO): DefineArg sink.MinOffshore = 2.000000 km
2025-04-22T16:40:54.120Z,1745340054.120 [MissionManager](INFO): DefineArg sink.SkipComms = 0 bool
2025-04-22T16:40:54.122Z,1745340054.122 [MissionManager](INFO): DefineOutput sink.MissionTimeout = 2.000000 h
2025-04-22T16:40:54.124Z,1745340054.124 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl
2025-04-22T16:40:54.124Z,1745340054.124 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl
2025-04-22T16:40:54.155Z,1745340054.155 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl
2025-04-22T16:40:57.387Z,1745340057.387 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into:
NaN
3
100
80
20
5
NaN
NaN
2.0
NaN
0
NaN
NaN
5
0
0
0
0
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
NaN
PeakDetectVsDepth
EdgeDetectVsDepth
GoDown, ChlPeakThresh, PeakChl, PeakChlDepth, EdgeChl, EdgeChlDepth =
,
,
,
,
,
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
PeakDetectVsDepth
_.planktivore_LM_AvgRois
EdgeDetectVsDepth
_.planktivore_LM_AvgRois
GoDown, PlanktivoreLMavgROIPeakThresh, PeakPlanktivoreLMavgROI, PeakPlanktivoreLMavgROIDepth, EdgePlanktivoreLMavgROI, EdgePlanktivoreLMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_HM_AvgRois
EdgeDetectVsDepth
_.planktivore_HM_AvgRois
GoDown, PlanktivoreHMavgROIPeakThresh, PeakPlanktivoreHMavgROI, PeakPlanktivoreHMavgROIDepth, EdgePlanktivoreHMavgROI, EdgePlanktivoreHMavgROIDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_diatoms
EdgeDetectVsDepth
_.planktivore_diatoms
GoDown, PlanktivoreDiatomsPeakThresh, PeakPlanktivoreDiatoms, PeakPlanktivoreDiatomsDepth, EdgePlanktivoreDiatoms, EdgePlanktivoreDiatomsDepth =
,
,
,
,
,
PeakDetectVsDepth
_.planktivore_dinoflagellates
EdgeDetectVsDepth
_.planktivore_dinoflagellates
GoDown, PlanktivoreDinoflagellatesPeakThresh, PeakPlanktivoreDinoflagellates, PeakPlanktivoreDinoflagellatesDepth, EdgePlanktivoreDinoflagellates, EdgePlanktivoreDinoflagellatesDepth =
,
,
,
,
,
Triggered. PeakChl values on
consecutive yo-yo profiles fall in [
] (NaN bound is ignored).
2025-04-22T16:40:57.427Z,1745340057.427 [MissionManager](INFO): DefineArg sink:Science.PeakDetectChlActive = 0 bool
2025-04-22T16:40:57.429Z,1745340057.429 [MissionManager](INFO): DefineArg sink:Science.EdgeDetectChlActive = 0 bool
2025-04-22T16:40:57.431Z,1745340057.431 [MissionManager](INFO): DefineArg sink:Science.TimeWindowPeakReport = nan min
2025-04-22T16:40:57.433Z,1745340057.433 [MissionManager](INFO): DefineArg sink:Science.HighestChlPeakReportActive = 0 bool
2025-04-22T16:40:57.434Z,1745340057.434 [MissionManager](INFO): DefineArg sink:Science.HighestSaltPeakReportActive = 0 bool
2025-04-22T16:40:57.436Z,1745340057.436 [MissionManager](INFO): DefineArg sink:Science.HighestOilPeakReportActive = 0 bool
2025-04-22T16:40:57.438Z,1745340057.438 [MissionManager](INFO): DefineArg sink:Science.PatchTracking = 0 bool
2025-04-22T16:40:57.440Z,1745340057.440 [MissionManager](INFO): DefineArg sink:Science.FilterWidthHorizontal = 3.000000 count
2025-04-22T16:40:57.443Z,1745340057.443 [MissionManager](INFO): DefineArg sink:Science.NumProfilesSlidingwindow = 100.000000 count
2025-04-22T16:40:57.445Z,1745340057.445 [MissionManager](INFO): DefineArg sink:Science.OffPeakFractionHorizontal = 80.000000 %
2025-04-22T16:40:57.447Z,1745340057.447 [MissionManager](INFO): DefineArg sink:Science.PeakDetectNO3Active = 0 bool
2025-04-22T16:40:57.449Z,1745340057.449 [MissionManager](INFO): DefineArg sink:Science.PeakDetectOilActive = 0 bool
2025-04-22T16:40:57.451Z,1745340057.451 [MissionManager](INFO): DefineArg sink:Science.PeakDetectFDOMActive = 0 bool
2025-04-22T16:40:57.453Z,1745340057.453 [MissionManager](INFO): DefineArg sink:Science.PeakDetectSalinityActive = 0 bool
2025-04-22T16:40:57.455Z,1745340057.455 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreLMavgROIActive = 0 bool
2025-04-22T16:40:57.457Z,1745340057.457 [MissionManager](INFO): DefineArg sink:Science.EdgeDetectPlanktivoreLMavgROIActive = 0 bool
2025-04-22T16:40:57.459Z,1745340057.459 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreHMavgROIActive = 0 bool
2025-04-22T16:40:57.501Z,1745340057.501 [MissionManager](INFO): DefineArg sink:Science.EdgeDetectPlanktivoreHMavgROIActive = 0 bool
2025-04-22T16:40:57.503Z,1745340057.503 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreDiatomsActive = 0 bool
2025-04-22T16:40:57.509Z,1745340057.509 [MissionManager](INFO): DefineArg sink:Science.EdgeDetectPlanktivoreDiatomsActive = 0 bool
2025-04-22T16:40:57.511Z,1745340057.511 [MissionManager](INFO): DefineArg sink:Science.PeakDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-04-22T16:40:57.529Z,1745340057.529 [MissionManager](INFO): DefineArg sink:Science.EdgeDetectPlanktivoreDinoflagellatesActive = 0 bool
2025-04-22T16:40:57.531Z,1745340057.531 [MissionManager](INFO): DefineArg sink:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2025-04-22T16:40:57.539Z,1745340057.539 [MissionManager](INFO): DefineArg sink:Science.EnabledAanderaaO2 = 0 bool
2025-04-22T16:40:57.605Z,1745340057.605 [MissionManager](INFO): DefineArg sink:Science.EnabledNeilBrown = 0 bool
2025-04-22T16:40:57.607Z,1745340057.607 [MissionManager](INFO): DefineArg sink:Science.EnabledSeabird = 1 bool
2025-04-22T16:40:57.623Z,1745340057.623 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsBB2FL = 1 bool
2025-04-22T16:40:57.637Z,1745340057.637 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2025-04-22T16:40:57.640Z,1745340057.640 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsUBAT = 0 bool
2025-04-22T16:40:57.656Z,1745340057.656 [MissionManager](INFO): DefineArg sink:Science.LowPassWindowLength = 20.000000 count
2025-04-22T16:40:57.662Z,1745340057.662 [MissionManager](INFO): DefineArg sink:Science.MedianFilterLen = 5.000000 count
2025-04-22T16:40:57.664Z,1745340057.664 [MissionManager](INFO): DefineArg sink:Science.ShallowBound = nan m
2025-04-22T16:40:57.666Z,1745340057.666 [MissionManager](INFO): DefineArg sink:Science.DeepBound = nan m
2025-04-22T16:40:57.687Z,1745340057.687 [MissionManager](INFO): DefineArg sink:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2025-04-22T16:40:57.690Z,1745340057.690 [MissionManager](INFO): DefineArg sink:Science.OffPeakFractionVertical = nan %
2025-04-22T16:40:57.692Z,1745340057.692 [MissionManager](INFO): DefineArg sink:Science.ChlPeakThresh = 0.000000 ug/l
2025-04-22T16:40:57.725Z,1745340057.725 [MissionManager](INFO): DefineArg sink:Science.ChlThreshTriggerActive = 0 bool
2025-04-22T16:40:57.727Z,1745340057.727 [MissionManager](INFO): DefineArg sink:Science.ChlLowerThresh = nan ug/l
2025-04-22T16:40:57.757Z,1745340057.757 [MissionManager](INFO): DefineArg sink:Science.ChlUpperThresh = nan ug/l
2025-04-22T16:40:57.759Z,1745340057.759 [MissionManager](INFO): DefineArg sink:Science.NumProfilesThresh = 5.000000 count
2025-04-22T16:40:57.762Z,1745340057.762 [MissionManager](INFO): DefineArg sink:Science.PlanktivoreLMavgROIPeakThresh = 0.000000 count/s
2025-04-22T16:40:57.764Z,1745340057.764 [MissionManager](INFO): DefineArg sink:Science.PlanktivoreHMavgROIPeakThresh = 0.000000 count/s
2025-04-22T16:40:57.780Z,1745340057.780 [MissionManager](INFO): DefineArg sink:Science.PlanktivoreDiatomsPeakThresh = 0.000000 count/ml
2025-04-22T16:40:57.782Z,1745340057.782 [MissionManager](INFO): DefineArg sink:Science.PlanktivoreDinoflagellatesPeakThresh = 0.000000 count/ml
2025-04-22T16:40:57.784Z,1745340057.784 [MissionManager](INFO): DefineOutput sink:Science.GoDown = 1 bool
2025-04-22T16:40:57.787Z,1745340057.787 [MissionManager](INFO): DefineOutput sink:Science.PeakChl = nan ug/l
2025-04-22T16:40:57.805Z,1745340057.805 [MissionManager](INFO): DefineOutput sink:Science.PeakChlDepth = nan m
2025-04-22T16:40:57.807Z,1745340057.807 [MissionManager](INFO): DefineOutput sink:Science.PeakChlTemperature = nan degC
2025-04-22T16:40:57.809Z,1745340057.809 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLatitude = nan arcdeg
2025-04-22T16:40:57.812Z,1745340057.812 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLongitude = nan arcdeg
2025-04-22T16:40:57.814Z,1745340057.814 [MissionManager](INFO): DefineOutput sink:Science.EdgeChl = nan ug/l
2025-04-22T16:40:57.830Z,1745340057.830 [MissionManager](INFO): DefineOutput sink:Science.EdgeChlDepth = nan m
2025-04-22T16:40:57.832Z,1745340057.832 [MissionManager](INFO): DefineOutput sink:Science.EdgeChlTemperature = nan degC
2025-04-22T16:40:57.835Z,1745340057.835 [MissionManager](INFO): DefineOutput sink:Science.EdgeChlLatitude = nan arcdeg
2025-04-22T16:40:57.837Z,1745340057.837 [MissionManager](INFO): DefineOutput sink:Science.EdgeChlLongitude = nan arcdeg
2025-04-22T16:40:57.839Z,1745340057.839 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3 = nan umol/l
2025-04-22T16:40:57.865Z,1745340057.865 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Depth = nan m
2025-04-22T16:40:57.867Z,1745340057.867 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Latitude = nan arcdeg
2025-04-22T16:40:57.870Z,1745340057.870 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Longitude = nan arcdeg
2025-04-22T16:40:57.872Z,1745340057.872 [MissionManager](INFO): DefineOutput sink:Science.PeakOil = nan kg/m3
2025-04-22T16:40:57.907Z,1745340057.907 [MissionManager](INFO): DefineOutput sink:Science.PeakOilDepth = nan m
2025-04-22T16:40:57.909Z,1745340057.909 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLatitude = nan arcdeg
2025-04-22T16:40:57.912Z,1745340057.912 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLongitude = nan arcdeg
2025-04-22T16:40:57.916Z,1745340057.916 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOM = nan ppb
2025-04-22T16:40:57.918Z,1745340057.918 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMDepth = nan m
2025-04-22T16:40:57.920Z,1745340057.920 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMTemperature = nan degC
2025-04-22T16:40:57.923Z,1745340057.923 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLatitude = nan arcdeg
2025-04-22T16:40:57.989Z,1745340057.989 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLongitude = nan arcdeg
2025-04-22T16:40:57.991Z,1745340057.991 [MissionManager](INFO): DefineOutput sink:Science.PeakSalt = nan psu
2025-04-22T16:40:58.010Z,1745340058.010 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltDepth = nan m
2025-04-22T16:40:58.012Z,1745340058.012 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltTemperature = nan degC
2025-04-22T16:40:58.027Z,1745340058.027 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLatitude = nan arcdeg
2025-04-22T16:40:58.041Z,1745340058.041 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLongitude = nan arcdeg
2025-04-22T16:40:58.044Z,1745340058.044 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROI = nan count/s
2025-04-22T16:40:58.062Z,1745340058.062 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROIDepth = nan m
2025-04-22T16:40:58.077Z,1745340058.077 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROITemperature = nan degC
2025-04-22T16:40:58.079Z,1745340058.079 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROILatitude = nan arcdeg
2025-04-22T16:40:58.091Z,1745340058.091 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreLMavgROILongitude = nan arcdeg
2025-04-22T16:40:58.143Z,1745340058.143 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreLMavgROI = nan count/s
2025-04-22T16:40:58.197Z,1745340058.197 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreLMavgROIDepth = nan m
2025-04-22T16:40:58.199Z,1745340058.199 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreLMavgROITemperature = nan degC
2025-04-22T16:40:58.206Z,1745340058.206 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreLMavgROILatitude = nan arcdeg
2025-04-22T16:40:58.208Z,1745340058.208 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreLMavgROILongitude = nan arcdeg
2025-04-22T16:40:58.227Z,1745340058.227 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROI = nan count/s
2025-04-22T16:40:58.250Z,1745340058.250 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROIDepth = nan m
2025-04-22T16:40:58.252Z,1745340058.252 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROITemperature = nan degC
2025-04-22T16:40:58.267Z,1745340058.267 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROILatitude = nan arcdeg
2025-04-22T16:40:58.289Z,1745340058.289 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreHMavgROILongitude = nan arcdeg
2025-04-22T16:40:58.292Z,1745340058.292 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreHMavgROI = nan count/s
2025-04-22T16:40:58.302Z,1745340058.302 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreHMavgROIDepth = nan m
2025-04-22T16:40:58.314Z,1745340058.314 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreHMavgROITemperature = nan degC
2025-04-22T16:40:58.316Z,1745340058.316 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreHMavgROILatitude = nan arcdeg
2025-04-22T16:40:58.331Z,1745340058.331 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreHMavgROILongitude = nan arcdeg
2025-04-22T16:40:58.346Z,1745340058.346 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatoms = nan count/ml
2025-04-22T16:40:58.348Z,1745340058.348 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsDepth = nan m
2025-04-22T16:40:58.391Z,1745340058.391 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsTemperature = nan degC
2025-04-22T16:40:58.410Z,1745340058.410 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsLatitude = nan arcdeg
2025-04-22T16:40:58.429Z,1745340058.429 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDiatomsLongitude = nan arcdeg
2025-04-22T16:40:58.431Z,1745340058.431 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDiatoms = nan count/ml
2025-04-22T16:40:58.444Z,1745340058.444 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDiatomsDepth = nan m
2025-04-22T16:40:58.466Z,1745340058.466 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDiatomsTemperature = nan degC
2025-04-22T16:40:58.477Z,1745340058.477 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDiatomsLatitude = nan arcdeg
2025-04-22T16:40:58.479Z,1745340058.479 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDiatomsLongitude = nan arcdeg
2025-04-22T16:40:58.482Z,1745340058.482 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellates = nan count/ml
2025-04-22T16:40:58.484Z,1745340058.484 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesDepth = nan m
2025-04-22T16:40:58.499Z,1745340058.499 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesTemperature = nan degC
2025-04-22T16:40:58.506Z,1745340058.506 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-04-22T16:40:58.509Z,1745340058.509 [MissionManager](INFO): DefineOutput sink:Science.PeakPlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-04-22T16:40:58.511Z,1745340058.511 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDinoflagellates = nan count/ml
2025-04-22T16:40:58.540Z,1745340058.540 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDinoflagellatesDepth = nan m
2025-04-22T16:40:58.543Z,1745340058.543 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDinoflagellatesTemperature = nan degC
2025-04-22T16:40:58.573Z,1745340058.573 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDinoflagellatesLatitude = nan arcdeg
2025-04-22T16:40:58.576Z,1745340058.576 [MissionManager](INFO): DefineOutput sink:Science.EdgePlanktivoreDinoflagellatesLongitude = nan arcdeg
2025-04-22T16:40:58.584Z,1745340058.584 [MissionManager](INFO): DefineOutput sink:Science.PatchChl = nan ug/l
2025-04-22T16:40:58.586Z,1745340058.586 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDepth = nan m
2025-04-22T16:40:58.613Z,1745340058.613 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLatitude = nan arcdeg
2025-04-22T16:40:58.615Z,1745340058.615 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLongitude = nan arcdeg
2025-04-22T16:40:58.618Z,1745340058.618 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDistance = nan m
2025-04-22T16:40:58.620Z,1745340058.620 [MissionManager](INFO): DefineOutput sink:Science.PatchSalt = nan psu
2025-04-22T16:40:58.637Z,1745340058.637 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDepth = nan m
2025-04-22T16:40:58.639Z,1745340058.639 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLatitude = nan arcdeg
2025-04-22T16:40:58.641Z,1745340058.641 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLongitude = nan arcdeg
2025-04-22T16:40:58.643Z,1745340058.643 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDistance = nan m
2025-04-22T16:40:58.666Z,1745340058.666 [MissionManager](INFO): DefineOutput sink:Science.PatchOil = nan psu
2025-04-22T16:40:58.677Z,1745340058.677 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDepth = nan m
2025-04-22T16:40:58.679Z,1745340058.679 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLatitude = nan arcdeg
2025-04-22T16:40:58.687Z,1745340058.687 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLongitude = nan arcdeg
2025-04-22T16:40:58.702Z,1745340058.702 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDistance = nan m
2025-04-22T16:40:58.704Z,1745340058.704 [MissionManager](INFO): DefineOutput sink:Science.TriggeredOnChl = 0 bool
2025-04-22T16:40:58.732Z,1745340058.732 [MissionManager](INFO): DefineOutput sink:Science.ChlTriggering = nan ug/l
2025-04-22T16:40:58.822Z,1745340058.822 [sink:Science:PeakDetectChl:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:58.866Z,1745340058.866 [sink:Science:EdgeDetectChl:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-22T16:40:58.948Z,1745340058.948 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-22T16:40:58.998Z,1745340058.998 [sink:Science:PeakDetectNO3:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.008Z,1745340059.008 [sink:Science:PeakDetectOil:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.036Z,1745340059.036 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-22T16:40:59.094Z,1745340059.094 [sink:Science:PeakDetectFDOM:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.118Z,1745340059.118 [sink:Science:PeakDetectSalinity:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.148Z,1745340059.148 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2025-04-22T16:40:59.244Z,1745340059.244 [sink:Science:PeakDetectPlanktivoreLMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.303Z,1745340059.303 [sink:Science:EdgeDetectPlanktivoreLMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-22T16:40:59.406Z,1745340059.406 [sink:Science:PeakDetectPlanktivoreHMavgROI:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.447Z,1745340059.447 [sink:Science:EdgeDetectPlanktivoreHMavgROI:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-22T16:40:59.488Z,1745340059.488 [sink:Science:PeakDetectPlanktivoreDiatoms:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.525Z,1745340059.525 [sink:Science:EdgeDetectPlanktivoreDiatoms:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-22T16:40:59.609Z,1745340059.609 [sink:Science:PeakDetectPlanktivoreDinoflagellates:B.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2025-04-22T16:40:59.634Z,1745340059.634 [sink:Science:EdgeDetectPlanktivoreDinoflagellates:B.EdgeDetectVsDepth](DEBUG): Construct EdgeDetectVsDepth.
2025-04-22T16:40:59.673Z,1745340059.673 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect.
2025-04-22T16:40:59.680Z,1745340059.680 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl
2025-04-22T16:40:59.680Z,1745340059.680 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl
2025-04-22T16:40:59.681Z,1745340059.681 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl
2025-04-22T16:40:59.867Z,1745340059.867 [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-22T16:40:59.871Z,1745340059.871 [MissionManager](INFO): DefineArg sink:NeedComms.DiveInterval = 1.000000 h
2025-04-22T16:40:59.874Z,1745340059.874 [MissionManager](INFO): DefineArg sink:NeedComms.WaitForPitchUp = 10.000000 min
2025-04-22T16:40:59.876Z,1745340059.876 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacePitch = 20.000000 arcdeg
2025-04-22T16:40:59.878Z,1745340059.878 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceDepthRate = nan m/s
2025-04-22T16:40:59.880Z,1745340059.880 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceSpeed = 1.000000 m/s
2025-04-22T16:40:59.882Z,1745340059.882 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacingTimeout = 1000.000000 s
2025-04-22T16:40:59.884Z,1745340059.884 [MissionManager](INFO): DefineArg sink:NeedComms.GPSTimeout = 7.000000 min
2025-04-22T16:40:59.887Z,1745340059.887 [MissionManager](INFO): DefineArg sink:NeedComms.CommsTimeout = 30.000000 min
2025-04-22T16:40:59.892Z,1745340059.892 [sink:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2025-04-22T16:40:59.997Z,1745340059.997 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl
2025-04-22T16:40:59.998Z,1745340059.998 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl
2025-04-22T16:40:59.999Z,1745340059.999 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl
2025-04-22T16:41:00.140Z,1745340060.140 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into:
5
0
200
2000
2025-04-22T16:41:00.146Z,1745340060.146 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinAltitude = 5.000000 m
2025-04-22T16:41:00.148Z,1745340060.148 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepthIgnore = 0.000000 m
2025-04-22T16:41:00.150Z,1745340060.150 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepth = 200.000000 m
2025-04-22T16:41:00.152Z,1745340060.152 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinOffshore = 2000.000000 m
2025-04-22T16:41:00.153Z,1745340060.153 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2025-04-22T16:41:00.159Z,1745340060.159 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2025-04-22T16:41:00.171Z,1745340060.171 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2025-04-22T16:41:00.179Z,1745340060.179 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2025-04-22T16:41:00.179Z,1745340060.179 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2025-04-22T16:41:00.180Z,1745340060.180 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2025-04-22T16:41:00.253Z,1745340060.253 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2025-04-22T16:41:00.256Z,1745340060.256 [MissionManager](INFO): DefineArg sink:BackseatDriver.EnableBackseat = 0 bool
2025-04-22T16:41:00.259Z,1745340060.259 [sink:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2025-04-22T16:41:00.261Z,1745340060.261 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl
2025-04-22T16:41:00.261Z,1745340060.261 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl
2025-04-22T16:41:00.262Z,1745340060.262 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl
2025-04-22T16:41:00.440Z,1745340060.440 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into:
99999
2025-04-22T16:41:00.444Z,1745340060.444 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleAll = 0 bool
2025-04-22T16:41:00.470Z,1745340060.470 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad1 = 0 bool
2025-04-22T16:41:00.472Z,1745340060.472 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad2 = 0 bool
2025-04-22T16:41:00.478Z,1745340060.478 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad3 = 0 bool
2025-04-22T16:41:00.480Z,1745340060.480 [MissionManager](INFO): DefineArg sink:PowerOnly.EnabledPowerOnly = 0 bool
2025-04-22T16:41:00.507Z,1745340060.507 [sink:PowerOnly:E.Wait](DEBUG): Construct Wait.
2025-04-22T16:41:00.515Z,1745340060.515 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BallastAndTrim.tl
2025-04-22T16:41:00.515Z,1745340060.515 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BallastAndTrim.tl
2025-04-22T16:41:00.516Z,1745340060.516 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BallastAndTrim.tl
2025-04-22T16:41:00.998Z,1745340060.998 [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-22T16:41:01.004Z,1745340061.004 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepth = 25.000000 m
2025-04-22T16:41:01.006Z,1745340061.006 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSpeed = 0.000000 m/s
2025-04-22T16:41:01.008Z,1745340061.008 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthRate = 0.400000 m/s
2025-04-22T16:41:01.011Z,1745340061.011 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachPitchLimit = 20.000000 arcdeg
2025-04-22T16:41:01.013Z,1745340061.013 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSettleTimePreDive = 0.000000 min
2025-04-22T16:41:01.015Z,1745340061.015 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = 20.000000 min
2025-04-22T16:41:01.017Z,1745340061.017 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = 10.000000 min
2025-04-22T16:41:01.019Z,1745340061.019 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstTimeout = 45.000000 min
2025-04-22T16:41:01.021Z,1745340061.021 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MinEstTime = 10.000000 min
2025-04-22T16:41:01.023Z,1745340061.023 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = 0.250000 mm
2025-04-22T16:41:01.025Z,1745340061.025 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = 15.000000 cc
2025-04-22T16:41:01.028Z,1745340061.028 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstConfidence = 99.900002 %
2025-04-22T16:41:01.030Z,1745340061.030 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = 1.000000 m
2025-04-22T16:41:01.032Z,1745340061.032 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertMassDeadband = 0.250000 mm
2025-04-22T16:41:01.044Z,1745340061.044 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Construct.
2025-04-22T16:41:01.091Z,1745340061.091 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Construct Buoyancy.
2025-04-22T16:41:01.106Z,1745340061.106 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Construct.
2025-04-22T16:41:01.140Z,1745340061.140 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Construct Wait.
2025-04-22T16:41:01.148Z,1745340061.148 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Construct.
2025-04-22T16:41:01.163Z,1745340061.163 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Construct.
2025-04-22T16:41:01.206Z,1745340061.206 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute.
2025-04-22T16:41:01.226Z,1745340061.226 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Construct.
2025-04-22T16:41:01.228Z,1745340061.228 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Construct.
2025-04-22T16:41:01.250Z,1745340061.250 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Construct Wait.
2025-04-22T16:41:01.251Z,1745340061.251 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:E.Execute](DEBUG): Construct Execute.
2025-04-22T16:41:01.263Z,1745340061.263 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:G.](DEBUG): Construct BallastAndTrim.
2025-04-22T16:41:01.268Z,1745340061.268 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = reader:sink.DepthDeadband
2025-04-22T16:41:01.302Z,1745340061.302 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = reader:sink.TargetDepthTimeout
2025-04-22T16:41:01.304Z,1745340061.304 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = reader:sink.BTSettleTime
2025-04-22T16:41:01.305Z,1745340061.305 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstTimeout = reader:sink.EstimationTimeout
2025-04-22T16:41:01.307Z,1745340061.307 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MinEstTime = reader:sink.MinEstimationTime
2025-04-22T16:41:01.308Z,1745340061.308 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = reader:sink.MassEstimationErrorBound
2025-04-22T16:41:01.309Z,1745340061.309 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = reader:sink.BuoyEstimationErrorBound
2025-04-22T16:41:01.311Z,1745340061.311 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstConfidence = reader:sink.EstimationConfidence
2025-04-22T16:41:01.321Z,1745340061.321 [sink:FloatUp:A.Buoyancy](DEBUG): Construct Buoyancy.
2025-04-22T16:41:01.324Z,1745340061.324 [sink:FloatUp:B.Wait](DEBUG): Construct Wait.
2025-04-22T16:41:01.486Z,1745340061.486 [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-22T16:41:01.487Z,1745340061.487 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/sink.tl id=sink
2025-04-22T16:41:15.512Z,1745340075.512 [CommandExec](IMPORTANT): got command set sink.SinkDuration 0.6 hour
2025-04-22T16:41:15.512Z,1745340075.512 [CommandExec](IMPORTANT): got command set sink.TargetDepthTimeout 12 hour
2025-04-22T16:41:15.513Z,1745340075.513 [CommandExec](IMPORTANT): got command set sink.MinAltitude 0.00001 meter
2025-04-22T16:41:15.514Z,1745340075.514 [CommandExec](IMPORTANT): got command set sink.MinOffshore 0.0001 kilometer
2025-04-22T16:41:15.514Z,1745340075.514 [CommandExec](IMPORTANT): got command run
2025-04-22T16:41:15.519Z,1745340075.519 [CommandExec](IMPORTANT): Running
2025-04-22T16:41:15.783Z,1745340075.783 [Default] Stopped
2025-04-22T16:41:15.784Z,1745340075.784 [Default](DEBUG): Aggregate::uninitialize Default
2025-04-22T16:41:15.784Z,1745340075.784 [Default:B.GoToSurface] Stopped
2025-04-22T16:41:15.784Z,1745340075.784 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-22T16:41:15.784Z,1745340075.784 [Default:CheckIn] Stopped
2025-04-22T16:41:15.784Z,1745340075.784 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-22T16:41:15.784Z,1745340075.784 [Default:CheckIn:C.Wait] Stopped
2025-04-22T16:41:15.784Z,1745340075.784 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-22T16:41:15.784Z,1745340075.784 [MissionManager](IMPORTANT): Started mission sink
2025-04-22T16:41:15.785Z,1745340075.785 [sink] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink](DEBUG): Aggregate::initialize sink
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science](DEBUG): Aggregate::initialize sink:Science
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science:A] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science:B] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science:C] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science:D] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science:E] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science:F] Running Loop=1
2025-04-22T16:41:15.785Z,1745340075.785 [sink:Science:Read_Oil] Running Loop=1
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:PeakDetectChl] Running Loop=1
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:PeakDetectChl](DEBUG): Aggregate::initialize sink:Science:PeakDetectChl
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:PeakDetectChl:A] Running Loop=1
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:EdgeDetectChl] Running Loop=1
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:EdgeDetectChl](DEBUG): Aggregate::initialize sink:Science:EdgeDetectChl
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:EdgeDetectChl:A] Running Loop=1
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:HighestChlPeakReport] Running Loop=1
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestChlPeakReport
2025-04-22T16:41:15.786Z,1745340075.786 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-22T16:41:15.787Z,1745340075.787 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-22T16:41:15.787Z,1745340075.787 [sink:Science:PeakDetectNO3] Running Loop=1
2025-04-22T16:41:15.787Z,1745340075.787 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sink:Science:PeakDetectNO3
2025-04-22T16:41:15.787Z,1745340075.787 [sink:Science:PeakDetectNO3:A] Running Loop=1
2025-04-22T16:41:15.787Z,1745340075.787 [sink:Science:PeakDetectOil] Running Loop=1
2025-04-22T16:41:15.787Z,1745340075.787 [sink:Science:PeakDetectOil](DEBUG): Aggregate::initialize sink:Science:PeakDetectOil
2025-04-22T16:41:15.787Z,1745340075.787 [sink:Science:PeakDetectOil:A] Running Loop=1
2025-04-22T16:41:15.788Z,1745340075.788 [sink:Science:HighestOilPeakReport] Running Loop=1
2025-04-22T16:41:15.788Z,1745340075.788 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestOilPeakReport
2025-04-22T16:41:15.788Z,1745340075.788 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-22T16:41:15.788Z,1745340075.788 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-22T16:41:15.788Z,1745340075.788 [sink:Science:PeakDetectFDOM] Running Loop=1
2025-04-22T16:41:15.788Z,1745340075.788 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sink:Science:PeakDetectFDOM
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:PeakDetectFDOM:A] Running Loop=1
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:PeakDetectSalinity] Running Loop=1
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize sink:Science:PeakDetectSalinity
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:PeakDetectSalinity:A] Running Loop=1
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:HighestSaltPeakReport] Running Loop=1
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestSaltPeakReport
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2025-04-22T16:41:15.789Z,1745340075.789 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2025-04-22T16:41:15.790Z,1745340075.790 [sink:Science:PeakDetectPlanktivoreLMavgROI] Running Loop=1
2025-04-22T16:41:15.790Z,1745340075.790 [sink:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreLMavgROI
2025-04-22T16:41:15.790Z,1745340075.790 [sink:Science:PeakDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-04-22T16:41:15.790Z,1745340075.790 [sink:Science:EdgeDetectPlanktivoreLMavgROI] Running Loop=1
2025-04-22T16:41:15.790Z,1745340075.790 [sink:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::initialize sink:Science:EdgeDetectPlanktivoreLMavgROI
2025-04-22T16:41:15.790Z,1745340075.790 [sink:Science:EdgeDetectPlanktivoreLMavgROI:A] Running Loop=1
2025-04-22T16:41:15.790Z,1745340075.790 [sink:Science:PeakDetectPlanktivoreHMavgROI] Running Loop=1
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreHMavgROI
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:PeakDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:EdgeDetectPlanktivoreHMavgROI] Running Loop=1
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:EdgeDetectPlanktivoreHMavgROI](DEBUG): Aggregate::initialize sink:Science:EdgeDetectPlanktivoreHMavgROI
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:EdgeDetectPlanktivoreHMavgROI:A] Running Loop=1
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:PeakDetectPlanktivoreDiatoms] Running Loop=1
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreDiatoms
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:PeakDetectPlanktivoreDiatoms:A] Running Loop=1
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:EdgeDetectPlanktivoreDiatoms] Running Loop=1
2025-04-22T16:41:15.791Z,1745340075.791 [sink:Science:EdgeDetectPlanktivoreDiatoms](DEBUG): Aggregate::initialize sink:Science:EdgeDetectPlanktivoreDiatoms
2025-04-22T16:41:15.792Z,1745340075.792 [sink:Science:EdgeDetectPlanktivoreDiatoms:A] Running Loop=1
2025-04-22T16:41:15.792Z,1745340075.792 [sink:Science:PeakDetectPlanktivoreDinoflagellates] Running Loop=1
2025-04-22T16:41:15.792Z,1745340075.792 [sink:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize sink:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-22T16:41:15.792Z,1745340075.792 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-04-22T16:41:15.792Z,1745340075.792 [sink:Science:EdgeDetectPlanktivoreDinoflagellates] Running Loop=1
2025-04-22T16:41:15.792Z,1745340075.792 [sink:Science:EdgeDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::initialize sink:Science:EdgeDetectPlanktivoreDinoflagellates
2025-04-22T16:41:15.793Z,1745340075.793 [sink:Science:EdgeDetectPlanktivoreDinoflagellates:A] Running Loop=1
2025-04-22T16:41:15.793Z,1745340075.793 [sink:Science:ChlThreshTrigger] Running Loop=1
2025-04-22T16:41:15.793Z,1745340075.793 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize sink:Science:ChlThreshTrigger
2025-04-22T16:41:15.793Z,1745340075.793 [sink:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1
2025-04-22T16:41:15.793Z,1745340075.793 [sink:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize.
2025-04-22T16:41:15.794Z,1745340075.794 [sink:Science:OceanCurrent] Running Loop=1
2025-04-22T16:41:15.794Z,1745340075.794 [sink:Science:OceanCurrent](DEBUG): Aggregate::initialize sink:Science:OceanCurrent
2025-04-22T16:41:15.794Z,1745340075.794 [sink:Science:OceanCurrent:A.] Running Loop=1
2025-04-22T16:41:15.794Z,1745340075.794 [sink:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2025-04-22T16:41:15.794Z,1745340075.794 [sink:StandardEnvelopes] Running Loop=1
2025-04-22T16:41:15.794Z,1745340075.794 [sink:StandardEnvelopes](DEBUG): Aggregate::initialize sink:StandardEnvelopes
2025-04-22T16:41:15.794Z,1745340075.794 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-04-22T16:41:15.794Z,1745340075.794 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2025-04-22T16:41:15.794Z,1745340075.794 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-04-22T16:41:15.794Z,1745340075.794 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2025-04-22T16:41:15.795Z,1745340075.795 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-04-22T16:41:15.795Z,1745340075.795 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2025-04-22T16:41:15.795Z,1745340075.795 [sink:BackseatDriver] Running Loop=1
2025-04-22T16:41:15.795Z,1745340075.795 [sink:BackseatDriver](DEBUG): Aggregate::initialize sink:BackseatDriver
2025-04-22T16:41:15.795Z,1745340075.795 [sink:BackseatDriver:A.BackseatDriver] Running Loop=1
2025-04-22T16:41:15.795Z,1745340075.795 [sink:PowerOnly] Running Loop=1
2025-04-22T16:41:15.795Z,1745340075.795 [sink:PowerOnly](DEBUG): Aggregate::initialize sink:PowerOnly
2025-04-22T16:41:15.795Z,1745340075.795 [sink:PowerOnly:A] Running Loop=1
2025-04-22T16:41:15.795Z,1745340075.795 [sink:PowerOnly:B] Running Loop=1
2025-04-22T16:41:15.795Z,1745340075.795 [sink:PowerOnly:C] Running Loop=1
2025-04-22T16:41:15.795Z,1745340075.795 [sink:PowerOnly:D] Running Loop=1
2025-04-22T16:41:15.796Z,1745340075.796 [sink:PowerOnly:E.Wait] Running Loop=1
2025-04-22T16:41:15.796Z,1745340075.796 [sink:PowerOnly:E.Wait](DEBUG): Initialize Wait Component.
2025-04-22T16:41:15.796Z,1745340075.796 [sink:A] Running Loop=1
2025-04-22T16:41:15.797Z,1745340075.797 [sink:PowerOnly] Running Loop=1
2025-04-22T16:41:15.797Z,1745340075.797 [sink:PowerOnly:D] Stopped
2025-04-22T16:41:15.797Z,1745340075.797 [sink:PowerOnly:C] Stopped
2025-04-22T16:41:15.797Z,1745340075.797 [sink:PowerOnly:B] Stopped
2025-04-22T16:41:15.797Z,1745340075.797 [sink:PowerOnly:A] Stopped
2025-04-22T16:41:15.797Z,1745340075.797 [sink:BackseatDriver] Running Loop=1
2025-04-22T16:41:15.798Z,1745340075.798 [sink:StandardEnvelopes] Running Loop=1
2025-04-22T16:41:15.798Z,1745340075.798 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2025-04-22T16:41:15.798Z,1745340075.798 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2025-04-22T16:41:15.798Z,1745340075.798 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2025-04-22T16:41:15.798Z,1745340075.798 [sink:Science] Running Loop=1
2025-04-22T16:41:15.800Z,1745340075.800 [sink:Science:ChlThreshTrigger] Stopped
2025-04-22T16:41:15.800Z,1745340075.800 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize sink:Science:ChlThreshTrigger
2025-04-22T16:41:15.800Z,1745340075.800 [sink:Science:ChlThreshTrigger:A.ValueDetect] Stopped
2025-04-22T16:41:15.800Z,1745340075.800 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize.
2025-04-22T16:41:15.800Z,1745340075.800 [sink:Science:EdgeDetectPlanktivoreDinoflagellates] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:EdgeDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize sink:Science:EdgeDetectPlanktivoreDinoflagellates
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:EdgeDetectPlanktivoreDinoflagellates:A] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:PeakDetectPlanktivoreDinoflagellates] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:PeakDetectPlanktivoreDinoflagellates](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreDinoflagellates
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:PeakDetectPlanktivoreDinoflagellates:A] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:EdgeDetectPlanktivoreDiatoms] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:EdgeDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize sink:Science:EdgeDetectPlanktivoreDiatoms
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:EdgeDetectPlanktivoreDiatoms:A] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:PeakDetectPlanktivoreDiatoms] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:PeakDetectPlanktivoreDiatoms](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreDiatoms
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:PeakDetectPlanktivoreDiatoms:A] Stopped
2025-04-22T16:41:15.801Z,1745340075.801 [sink:Science:EdgeDetectPlanktivoreHMavgROI] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:EdgeDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize sink:Science:EdgeDetectPlanktivoreHMavgROI
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:EdgeDetectPlanktivoreHMavgROI:A] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:PeakDetectPlanktivoreHMavgROI] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:PeakDetectPlanktivoreHMavgROI](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreHMavgROI
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:PeakDetectPlanktivoreHMavgROI:A] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:EdgeDetectPlanktivoreLMavgROI] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:EdgeDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize sink:Science:EdgeDetectPlanktivoreLMavgROI
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:EdgeDetectPlanktivoreLMavgROI:A] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:PeakDetectPlanktivoreLMavgROI] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:PeakDetectPlanktivoreLMavgROI](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectPlanktivoreLMavgROI
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:PeakDetectPlanktivoreLMavgROI:A] Stopped
2025-04-22T16:41:15.802Z,1745340075.802 [sink:Science:HighestSaltPeakReport] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestSaltPeakReport
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:PeakDetectSalinity] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectSalinity
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:PeakDetectSalinity:A] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:PeakDetectFDOM] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectFDOM
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:PeakDetectFDOM:A] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:HighestOilPeakReport] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestOilPeakReport
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-22T16:41:15.803Z,1745340075.803 [sink:Science:PeakDetectOil] Stopped
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectOil
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:PeakDetectOil:A] Stopped
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:PeakDetectNO3] Stopped
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectNO3
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:PeakDetectNO3:A] Stopped
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:HighestChlPeakReport] Stopped
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestChlPeakReport
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:EdgeDetectChl] Stopped
2025-04-22T16:41:15.804Z,1745340075.804 [sink:Science:EdgeDetectChl](DEBUG): Aggregate::uninitialize sink:Science:EdgeDetectChl
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:EdgeDetectChl:A] Stopped
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:PeakDetectChl] Stopped
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectChl
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:PeakDetectChl:A] Stopped
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:OceanCurrent:A.] Running Loop=1
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:Read_Oil] Stopped
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:F] Stopped
2025-04-22T16:41:15.806Z,1745340075.806 [sink:Science:E] Running Loop=1
2025-04-22T16:41:15.807Z,1745340075.807 [sink:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2025-04-22T16:41:15.807Z,1745340075.807 [sink:Science:D] Stopped
2025-04-22T16:41:15.807Z,1745340075.807 [sink:Science:C] Running Loop=1
2025-04-22T16:41:15.807Z,1745340075.807 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2025-04-22T16:41:15.808Z,1745340075.808 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2025-04-22T16:41:15.808Z,1745340075.808 [sink:Science:B] Running Loop=1
2025-04-22T16:41:15.808Z,1745340075.808 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2025-04-22T16:41:15.809Z,1745340075.809 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2025-04-22T16:41:15.809Z,1745340075.809 [sink:Science:A] Stopped
2025-04-22T16:41:15.809Z,1745340075.809 [sink:A] Stopped
2025-04-22T16:41:15.810Z,1745340075.810 [sink:D] Running Loop=1
2025-04-22T16:41:16.058Z,1745340076.058 [WetLabsBB2FL](INFO): Powering up
2025-04-22T16:41:16.173Z,1745340076.173 [sink:D] Stopped
2025-04-22T16:41:16.173Z,1745340076.173 [sink:F] Running Loop=1
2025-04-22T16:41:16.585Z,1745340076.585 [sink:F] Stopped
2025-04-22T16:41:16.585Z,1745340076.585 [sink:G] Running Loop=1
2025-04-22T16:41:16.983Z,1745340076.983 [sink:G] Stopped
2025-04-22T16:41:16.983Z,1745340076.983 [sink:H] Running Loop=1
2025-04-22T16:41:17.391Z,1745340077.391 [sink:H] Stopped
2025-04-22T16:41:17.391Z,1745340077.391 [sink:startComms] Running Loop=1
2025-04-22T16:41:17.392Z,1745340077.392 [sink:startComms](DEBUG): Aggregate::initialize sink:startComms
2025-04-22T16:41:17.392Z,1745340077.392 [sink:startComms:StartingMission] Running Loop=1
2025-04-22T16:41:17.392Z,1745340077.392 [sink:startComms:StartingMission](DEBUG): Aggregate::initialize sink:startComms:StartingMission
2025-04-22T16:41:17.792Z,1745340077.792 [sink:NeedComms] Running Loop=1
2025-04-22T16:41:17.801Z,1745340077.801 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms
2025-04-22T16:41:17.801Z,1745340077.801 [sink:NeedComms:B.GoToSurface] Running Loop=1
2025-04-22T16:41:17.801Z,1745340077.801 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-22T16:41:17.801Z,1745340077.801 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-04-22T16:41:17.802Z,1745340077.802 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-04-22T16:41:17.802Z,1745340077.802 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-04-22T16:41:17.802Z,1745340077.802 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-04-22T16:41:17.803Z,1745340077.803 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-22T16:41:17.803Z,1745340077.803 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-22T16:41:17.803Z,1745340077.803 [sink:NeedComms:A] Running Loop=1
2025-04-22T16:41:17.805Z,1745340077.805 [sink:NeedComms:A](INFO): last time_fix was: 1745337615.000000 second since 1970/01/01T00:00:00Z
2025-04-22T16:41:17.805Z,1745340077.805 [sink:NeedComms:A] Stopped
2025-04-22T16:41:18.201Z,1745340078.201 [sink:NeedComms:C] Running Loop=1
2025-04-22T16:41:18.601Z,1745340078.601 [sink:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-22T16:41:19.466Z,1745340079.466 [CTD_Seabird](ERROR): Failed to parse device response:
2025-04-22T16:41:20.206Z,1745340080.206 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164118.00,A,3648.16943,N,12147.28305,W,0.156,32.49,220425,,,D*42
2025-04-22T16:41:20.208Z,1745340080.208 [NAL9602](INFO): GPS fix at 20250422T164118: (36.802824, -121.788051)
2025-04-22T16:41:20.220Z,1745340080.220 [sink:NeedComms:C] Stopped
2025-04-22T16:41:20.220Z,1745340080.220 [sink:NeedComms:D] Running Loop=1
2025-04-22T16:41:20.678Z,1745340080.678 [sink:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2025-04-22T16:41:24.639Z,1745340084.639 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20250422T163301/Courier0006.lzma
2025-04-22T16:41:25.342Z,1745340085.342 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Courier0006.lzma.bak
2025-04-22T16:41:25.343Z,1745340085.343 [DataOverHttps](INFO): SBD MOMSN=24710348
2025-04-22T16:41:44.816Z,1745340104.816 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250422T163301/Courier0009.lzma
2025-04-22T16:41:45.819Z,1745340105.819 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Courier0009.lzma.bak
2025-04-22T16:41:45.819Z,1745340105.819 [DataOverHttps](INFO): SBD MOMSN=24710351
2025-04-22T16:41:55.958Z,1745340115.958 [CommandExec](IMPORTANT): got command set NAL9602.platform_communications 1 bool
2025-04-22T16:42:08.542Z,1745340128.542 [DataOverHttps](INFO): Sending 695 bytes from file Logs/20250422T163301/Express0007.lzma
2025-04-22T16:42:09.543Z,1745340129.543 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0007.lzma.bak
2025-04-22T16:42:09.543Z,1745340129.543 [DataOverHttps](INFO): SBD MOMSN=24710353
2025-04-22T16:42:20.636Z,1745340140.636 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1745340129 second
2025-04-22T16:42:25.829Z,1745340145.829 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250422T163301/Express0010.lzma
2025-04-22T16:42:26.831Z,1745340146.831 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0010.lzma.bak
2025-04-22T16:42:26.831Z,1745340146.831 [DataOverHttps](INFO): SBD MOMSN=24710372
2025-04-22T16:42:28.238Z,1745340148.238 [sink:NeedComms:D] Stopped
2025-04-22T16:42:28.238Z,1745340148.238 [sink:NeedComms:E] Running Loop=1
2025-04-22T16:42:28.656Z,1745340148.656 [sink:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2025-04-22T16:43:16.187Z,1745340196.187 [CommandExec](IMPORTANT): got command set sink.SinkDuration 0.6 hour
2025-04-22T16:43:16.188Z,1745340196.188 [CommandExec](IMPORTANT): got command set sink.TargetDepthTimeout 12 hour
2025-04-22T16:43:16.188Z,1745340196.188 [CommandExec](IMPORTANT): got command set sink.MinAltitude 0.00001 meter
2025-04-22T16:43:16.189Z,1745340196.189 [CommandExec](IMPORTANT): got command set sink.MinOffshore 0.0001 kilometer
2025-04-22T16:43:16.190Z,1745340196.190 [CommandExec](IMPORTANT): got command run
2025-04-22T16:43:16.192Z,1745340196.192 [CommandExec](IMPORTANT): Running
2025-04-22T16:43:16.193Z,1745340196.193 [CommandExec](IMPORTANT): got command failComponent
2025-04-22T16:43:16.193Z,1745340196.193 [CommandExec](IMPORTANT): Failed components:
2025-04-22T16:43:16.193Z,1745340196.193 [CommandExec](IMPORTANT): No failed Components.
2025-04-22T16:44:41.942Z,1745340281.942 [CommandExec](IMPORTANT): got command show stack
2025-04-22T16:44:41.942Z,1745340281.942 [CommandExec](IMPORTANT): Behavior Stack:
2025-04-22T16:44:41.944Z,1745340281.944 [sink:Science](IMPORTANT): Priority 0: sink:Science:B
2025-04-22T16:44:41.945Z,1745340281.945 [sink:Science](IMPORTANT): Priority 1: sink:Science:C
2025-04-22T16:44:41.945Z,1745340281.945 [sink:Science](IMPORTANT): Priority 2: sink:Science:E
2025-04-22T16:44:41.945Z,1745340281.945 [sink:Science:OceanCurrent](IMPORTANT): Priority 3: sink:Science:OceanCurrent:A.
2025-04-22T16:44:41.945Z,1745340281.945 [sink:NeedComms](IMPORTANT): Priority 4: sink:NeedComms:B.GoToSurface
2025-04-22T16:44:41.946Z,1745340281.946 [sink:NeedComms](IMPORTANT): Priority 5: sink:NeedComms:E
2025-04-22T16:44:41.946Z,1745340281.946 [sink:StandardEnvelopes](IMPORTANT): Priority 6: sink:StandardEnvelopes:A.AltitudeEnvelope
2025-04-22T16:44:41.946Z,1745340281.946 [sink:StandardEnvelopes](IMPORTANT): Priority 7: sink:StandardEnvelopes:B.DepthEnvelope
2025-04-22T16:44:41.946Z,1745340281.946 [sink:StandardEnvelopes](IMPORTANT): Priority 8: sink:StandardEnvelopes:C.OffshoreEnvelope
2025-04-22T16:44:41.947Z,1745340281.947 [sink:BackseatDriver](IMPORTANT): Priority 9: sink:BackseatDriver:A.BackseatDriver
2025-04-22T16:44:41.947Z,1745340281.947 [sink:PowerOnly](IMPORTANT): Priority 10: sink:PowerOnly:E.Wait
2025-04-22T16:45:09.727Z,1745340309.727 [CommandExec](IMPORTANT): got command set NAL9602.platform_communications 1 bool
2025-04-22T16:45:27.778Z,1745340327.778 [CommandExec](IMPORTANT): got command get PowerOnly.loadAtStartup
2025-04-22T16:45:27.779Z,1745340327.779 [CommandExec](IMPORTANT): PowerOnly.loadAtStartup 0 bool
2025-04-22T16:45:46.128Z,1745340346.128 [CommandExec](IMPORTANT): got command get SpeedControl.speedCmd
2025-04-22T16:45:46.129Z,1745340346.129 [CommandExec](IMPORTANT): SpeedControl.speedCmd 0.000000 m/s
2025-04-22T16:46:22.149Z,1745340382.149 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-22T16:46:27.006Z,1745340387.006 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164626.00,A,3648.16475,N,12147.28371,W,0.214,141.47,220425,,,D*7D
2025-04-22T16:46:27.008Z,1745340387.008 [NAL9602](INFO): GPS fix at 20250422T164626: (36.802746, -121.788062)
2025-04-22T16:46:27.062Z,1745340387.062 [sink:NeedComms:E] Stopped
2025-04-22T16:46:27.064Z,1745340387.064 [sink:NeedComms](INFO): Completed sink:NeedComms
2025-04-22T16:46:27.064Z,1745340387.064 [sink:NeedComms] Stopped
2025-04-22T16:46:27.064Z,1745340387.064 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms
2025-04-22T16:46:27.064Z,1745340387.064 [sink:NeedComms:B.GoToSurface] Stopped
2025-04-22T16:46:27.064Z,1745340387.064 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-22T16:46:27.433Z,1745340387.433 [sink:startComms:StartingMission](INFO): Completed sink:startComms:StartingMission
2025-04-22T16:46:27.433Z,1745340387.433 [sink:startComms:StartingMission] Stopped
2025-04-22T16:46:27.433Z,1745340387.433 [sink:startComms:StartingMission](DEBUG): Aggregate::uninitialize sink:startComms:StartingMission
2025-04-22T16:46:27.433Z,1745340387.433 [sink:startComms](INFO): Completed sink:startComms
2025-04-22T16:46:27.433Z,1745340387.433 [sink:startComms] Stopped
2025-04-22T16:46:27.433Z,1745340387.433 [sink:startComms](DEBUG): Aggregate::uninitialize sink:startComms
2025-04-22T16:46:27.433Z,1745340387.433 [sink:RunSink] Running Loop=1
2025-04-22T16:46:27.433Z,1745340387.433 [sink:RunSink](DEBUG): Aggregate::initialize sink:RunSink
2025-04-22T16:46:27.434Z,1745340387.434 [sink:RunSink:RunBallastAndTrim] Running Loop=1
2025-04-22T16:46:27.434Z,1745340387.434 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:RunBallastAndTrim
2025-04-22T16:46:27.434Z,1745340387.434 [sink:RunSink:RunBallastAndTrim:A] Running Loop=1
2025-04-22T16:46:27.836Z,1745340387.836 [sink:RunSink:RunBallastAndTrim] Stopped
2025-04-22T16:46:27.836Z,1745340387.836 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:RunBallastAndTrim
2025-04-22T16:46:27.836Z,1745340387.836 [sink:RunSink:RunBallastAndTrim:A] Stopped
2025-04-22T16:46:27.836Z,1745340387.836 [sink:RunSink:JustSink] Running Loop=1
2025-04-22T16:46:27.836Z,1745340387.836 [sink:RunSink:JustSink](DEBUG): Aggregate::initialize sink:RunSink:JustSink
2025-04-22T16:46:27.836Z,1745340387.836 [sink:RunSink:JustSink:A] Running Loop=1
2025-04-22T16:46:28.258Z,1745340388.258 [sink:RunSink:JustSink:A] Stopped
2025-04-22T16:46:28.258Z,1745340388.258 [sink:RunSink:JustSink:B] Running Loop=1
2025-04-22T16:46:28.644Z,1745340388.644 [sink:RunSink:JustSink:B] Stopped
2025-04-22T16:46:28.644Z,1745340388.644 [sink:RunSink:JustSink:C] Running Loop=1
2025-04-22T16:46:28.644Z,1745340388.644 [sink:RunSink:JustSink:C](DEBUG): Aggregate::initialize sink:RunSink:JustSink:C
2025-04-22T16:46:29.049Z,1745340389.049 [sink:RunSink:BallastAndTrim] Running Loop=1
2025-04-22T16:46:29.050Z,1745340389.050 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim
2025-04-22T16:46:29.050Z,1745340389.050 [sink:RunSink:BallastAndTrim:A] Running Loop=1
2025-04-22T16:46:29.050Z,1745340389.050 [sink:RunSink:BallastAndTrim:B] Running Loop=1
2025-04-22T16:46:29.050Z,1745340389.050 [sink:RunSink:BallastAndTrim:C] Running Loop=1
2025-04-22T16:46:29.050Z,1745340389.050 [sink:RunSink:BallastAndTrim:D] Running Loop=1
2025-04-22T16:46:29.050Z,1745340389.050 [sink:RunSink:BallastAndTrim:E] Running Loop=1
2025-04-22T16:46:29.050Z,1745340389.050 [sink:RunSink:BallastAndTrim:F] Running Loop=1
2025-04-22T16:46:29.052Z,1745340389.052 [sink:RunSink:BallastAndTrim:F](INFO): Going to target depth. Speed set to 0.000000 m/s
2025-04-22T16:46:29.052Z,1745340389.052 [sink:RunSink:BallastAndTrim:F] Stopped
2025-04-22T16:46:29.052Z,1745340389.052 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Running Loop=1
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Running Loop=1
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Running Loop=1
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Initialize.
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Running Loop=1
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Running Loop=1
2025-04-22T16:46:29.057Z,1745340389.057 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Initialize.
2025-04-22T16:46:29.058Z,1745340389.058 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Running Loop=1
2025-04-22T16:46:29.058Z,1745340389.058 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive
2025-04-22T16:46:29.058Z,1745340389.058 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Running Loop=1
2025-04-22T16:46:29.058Z,1745340389.058 [sink:RunSink:BallastAndTrim:E] Running Loop=1
2025-04-22T16:46:29.058Z,1745340389.058 [sink:RunSink:BallastAndTrim:D] Running Loop=1
2025-04-22T16:46:29.059Z,1745340389.059 [sink:RunSink:BallastAndTrim:C] Running Loop=1
2025-04-22T16:46:29.059Z,1745340389.059 [sink:RunSink:BallastAndTrim:B] Running Loop=1
2025-04-22T16:46:29.059Z,1745340389.059 [sink:RunSink:BallastAndTrim:A] Running Loop=1
2025-04-22T16:46:29.454Z,1745340389.454 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A](INFO): Waiting for 0.000000 min while pumping down to neutral.
2025-04-22T16:46:29.454Z,1745340389.454 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Stopped
2025-04-22T16:46:29.454Z,1745340389.454 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Running Loop=1
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Initialize Wait Component.
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Stopped
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Stopped
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Stopped
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Stopped
2025-04-22T16:46:29.455Z,1745340389.455 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](INFO): Done Waiting.
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Stopped
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Uninitialize Wait Component.
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Stopped
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Running Loop=1
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1
2025-04-22T16:46:29.843Z,1745340389.843 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Initialize.
2025-04-22T16:46:29.844Z,1745340389.844 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Running Loop=1
2025-04-22T16:46:30.262Z,1745340390.262 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1
2025-04-22T16:46:30.263Z,1745340390.263 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A](INFO): Moving to 20.000000 m
2025-04-22T16:46:30.263Z,1745340390.263 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Stopped
2025-04-22T16:46:30.263Z,1745340390.263 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Running Loop=1
2025-04-22T16:46:30.263Z,1745340390.263 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Initialize.
2025-04-22T16:46:36.191Z,1745340396.191 [Reporter](INFO): platform_buoyancy_position 998.896179 cc
2025-04-22T16:46:36.491Z,1745340396.491 [Reporter](INFO): platform_buoyancy_position 998.761841 cc
2025-04-22T16:46:36.798Z,1745340396.798 [Reporter](INFO): platform_buoyancy_position 996.881775 cc
2025-04-22T16:46:37.299Z,1745340397.299 [Reporter](INFO): platform_buoyancy_position 986.272034 cc
2025-04-22T16:46:37.572Z,1745340397.572 [Reporter](INFO): platform_buoyancy_position 986.003418 cc
2025-04-22T16:46:37.987Z,1745340397.987 [Reporter](INFO): platform_buoyancy_position 981.705872 cc
2025-04-22T16:46:38.423Z,1745340398.423 [Reporter](INFO): platform_buoyancy_position 977.408264 cc
2025-04-22T16:46:38.812Z,1745340398.812 [Reporter](INFO): platform_buoyancy_position 973.110596 cc
2025-04-22T16:46:39.223Z,1745340399.223 [Reporter](INFO): platform_buoyancy_position 968.812988 cc
2025-04-22T16:46:39.619Z,1745340399.619 [Reporter](INFO): platform_buoyancy_position 963.843872 cc
2025-04-22T16:46:40.044Z,1745340400.044 [Reporter](INFO): platform_buoyancy_position 958.068970 cc
2025-04-22T16:46:40.456Z,1745340400.456 [Reporter](INFO): platform_buoyancy_position 951.622559 cc
2025-04-22T16:46:40.884Z,1745340400.884 [Reporter](INFO): platform_buoyancy_position 947.324951 cc
2025-04-22T16:46:41.251Z,1745340401.251 [Reporter](INFO): platform_buoyancy_position 942.893066 cc
2025-04-22T16:46:41.675Z,1745340401.675 [Reporter](INFO): platform_buoyancy_position 936.715332 cc
2025-04-22T16:46:42.072Z,1745340402.072 [Reporter](INFO): platform_buoyancy_position 932.283325 cc
2025-04-22T16:46:42.472Z,1745340402.472 [Reporter](INFO): platform_buoyancy_position 925.971313 cc
2025-04-22T16:46:42.992Z,1745340402.992 [Reporter](INFO): platform_buoyancy_position 919.390625 cc
2025-04-22T16:46:43.284Z,1745340403.284 [Reporter](INFO): platform_buoyancy_position 915.227295 cc
2025-04-22T16:46:43.667Z,1745340403.667 [Reporter](INFO): platform_buoyancy_position 910.795410 cc
2025-04-22T16:46:44.095Z,1745340404.095 [Reporter](INFO): platform_buoyancy_position 904.348999 cc
2025-04-22T16:46:44.503Z,1745340404.503 [Reporter](INFO): platform_buoyancy_position 898.574097 cc
2025-04-22T16:46:44.917Z,1745340404.917 [Reporter](INFO): platform_buoyancy_position 893.739258 cc
2025-04-22T16:46:45.287Z,1745340405.287 [Reporter](INFO): platform_buoyancy_position 889.307373 cc
2025-04-22T16:46:45.702Z,1745340405.702 [Reporter](INFO): platform_buoyancy_position 884.338257 cc
2025-04-22T16:46:46.105Z,1745340406.105 [Reporter](INFO): platform_buoyancy_position 878.563354 cc
2025-04-22T16:46:46.266Z,1745340406.266 [CommandExec](IMPORTANT): got command set sink:NeedComms.GPSTimeout 1 minute
2025-04-22T16:46:46.496Z,1745340406.496 [Reporter](INFO): platform_buoyancy_position 873.862915 cc
2025-04-22T16:46:46.906Z,1745340406.906 [Reporter](INFO): platform_buoyancy_position 867.953735 cc
2025-04-22T16:46:47.270Z,1745340407.270 [Reporter](INFO): platform_buoyancy_position 863.656128 cc
2025-04-22T16:46:47.784Z,1745340407.784 [Reporter](INFO): platform_buoyancy_position 857.209717 cc
2025-04-22T16:46:48.207Z,1745340408.207 [Reporter](INFO): platform_buoyancy_position 852.912109 cc
2025-04-22T16:46:48.507Z,1745340408.507 [Reporter](INFO): platform_buoyancy_position 848.480225 cc
2025-04-22T16:46:49.007Z,1745340409.007 [Reporter](INFO): platform_buoyancy_position 842.033813 cc
2025-04-22T16:46:49.271Z,1745340409.271 [Reporter](INFO): platform_buoyancy_position 837.198975 cc
2025-04-22T16:46:49.676Z,1745340409.676 [Reporter](INFO): platform_buoyancy_position 831.289795 cc
2025-04-22T16:46:50.092Z,1745340410.092 [Reporter](INFO): platform_buoyancy_position 826.992188 cc
2025-04-22T16:46:50.510Z,1745340410.510 [Reporter](INFO): platform_buoyancy_position 820.680054 cc
2025-04-22T16:46:50.908Z,1745340410.908 [Reporter](INFO): platform_buoyancy_position 816.248169 cc
2025-04-22T16:46:51.290Z,1745340411.290 [Reporter](INFO): platform_buoyancy_position 809.936096 cc
2025-04-22T16:46:51.708Z,1745340411.708 [Reporter](INFO): platform_buoyancy_position 805.504150 cc
2025-04-22T16:46:52.112Z,1745340412.112 [Reporter](INFO): platform_buoyancy_position 799.192078 cc
2025-04-22T16:46:52.524Z,1745340412.524 [Reporter](INFO): platform_buoyancy_position 794.760193 cc
2025-04-22T16:46:52.957Z,1745340412.957 [Reporter](INFO): platform_buoyancy_position 788.313782 cc
2025-04-22T16:46:53.320Z,1745340413.320 [Reporter](INFO): platform_buoyancy_position 784.150452 cc
2025-04-22T16:46:53.732Z,1745340413.732 [Reporter](INFO): platform_buoyancy_position 778.778442 cc
2025-04-22T16:46:54.144Z,1745340414.144 [Reporter](INFO): platform_buoyancy_position 773.272156 cc
2025-04-22T16:46:54.516Z,1745340414.516 [Reporter](INFO): platform_buoyancy_position 768.974548 cc
2025-04-22T16:46:54.933Z,1745340414.933 [Reporter](INFO): platform_buoyancy_position 762.662476 cc
2025-04-22T16:46:55.348Z,1745340415.348 [Reporter](INFO): platform_buoyancy_position 758.230591 cc
2025-04-22T16:46:55.752Z,1745340415.752 [Reporter](INFO): platform_buoyancy_position 751.784180 cc
2025-04-22T16:46:56.136Z,1745340416.136 [Reporter](INFO): platform_buoyancy_position 747.486572 cc
2025-04-22T16:46:56.552Z,1745340416.552 [Reporter](INFO): platform_buoyancy_position 741.174500 cc
2025-04-22T16:46:56.964Z,1745340416.964 [Reporter](INFO): platform_buoyancy_position 736.742554 cc
2025-04-22T16:46:57.372Z,1745340417.372 [Reporter](INFO): platform_buoyancy_position 730.296143 cc
2025-04-22T16:46:57.763Z,1745340417.763 [Reporter](INFO): platform_buoyancy_position 725.998596 cc
2025-04-22T16:46:58.180Z,1745340418.180 [Reporter](INFO): platform_buoyancy_position 719.686462 cc
2025-04-22T16:46:58.584Z,1745340418.584 [Reporter](INFO): platform_buoyancy_position 715.388855 cc
2025-04-22T16:46:58.984Z,1745340418.984 [Reporter](INFO): platform_buoyancy_position 708.808167 cc
2025-04-22T16:46:59.316Z,1745340419.316 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-22T16:46:59.380Z,1745340419.380 [Reporter](INFO): platform_buoyancy_position 704.644836 cc
2025-04-22T16:46:59.800Z,1745340419.800 [Reporter](INFO): platform_buoyancy_position 698.064148 cc
2025-04-22T16:47:00.211Z,1745340420.211 [Reporter](INFO): platform_buoyancy_position 693.766541 cc
2025-04-22T16:47:00.610Z,1745340420.610 [Reporter](INFO): platform_buoyancy_position 687.588745 cc
2025-04-22T16:47:01.003Z,1745340421.003 [Reporter](INFO): platform_buoyancy_position 683.156860 cc
2025-04-22T16:47:01.476Z,1745340421.476 [Reporter](INFO): platform_buoyancy_position 676.576172 cc
2025-04-22T16:47:01.848Z,1745340421.848 [Reporter](INFO): platform_buoyancy_position 672.278564 cc
2025-04-22T16:47:02.220Z,1745340422.220 [Reporter](INFO): platform_buoyancy_position 667.980957 cc
2025-04-22T16:47:02.632Z,1745340422.632 [Reporter](INFO): platform_buoyancy_position 661.668884 cc
2025-04-22T16:47:03.048Z,1745340423.048 [Reporter](INFO): platform_buoyancy_position 655.222473 cc
2025-04-22T16:47:03.456Z,1745340423.456 [Reporter](INFO): platform_buoyancy_position 650.790588 cc
2025-04-22T16:47:03.835Z,1745340423.835 [Reporter](INFO): platform_buoyancy_position 646.492981 cc
2025-04-22T16:47:04.257Z,1745340424.257 [Reporter](INFO): platform_buoyancy_position 640.046570 cc
2025-04-22T16:47:04.650Z,1745340424.650 [Reporter](INFO): platform_buoyancy_position 635.748962 cc
2025-04-22T16:47:05.040Z,1745340425.040 [Reporter](INFO): platform_buoyancy_position 631.048462 cc
2025-04-22T16:47:05.557Z,1745340425.557 [Reporter](INFO): platform_buoyancy_position 625.139282 cc
2025-04-22T16:47:05.983Z,1745340425.983 [Reporter](INFO): platform_buoyancy_position 619.498657 cc
2025-04-22T16:47:06.271Z,1745340426.271 [Reporter](INFO): platform_buoyancy_position 614.395264 cc
2025-04-22T16:47:06.671Z,1745340426.671 [Reporter](INFO): platform_buoyancy_position 609.694763 cc
2025-04-22T16:47:07.183Z,1745340427.183 [Reporter](INFO): platform_buoyancy_position 603.651245 cc
2025-04-22T16:47:07.479Z,1745340427.479 [Reporter](INFO): platform_buoyancy_position 598.682129 cc
2025-04-22T16:47:07.860Z,1745340427.860 [Reporter](INFO): platform_buoyancy_position 592.907288 cc
2025-04-22T16:47:08.284Z,1745340428.284 [Reporter](INFO): platform_buoyancy_position 588.475342 cc
2025-04-22T16:47:08.693Z,1745340428.693 [Reporter](INFO): platform_buoyancy_position 582.028931 cc
2025-04-22T16:47:09.078Z,1745340429.078 [Reporter](INFO): platform_buoyancy_position 577.731384 cc
2025-04-22T16:47:09.499Z,1745340429.499 [Reporter](INFO): platform_buoyancy_position 571.284973 cc
2025-04-22T16:47:09.923Z,1745340429.923 [Reporter](INFO): platform_buoyancy_position 567.121643 cc
2025-04-22T16:47:10.300Z,1745340430.300 [Reporter](INFO): platform_buoyancy_position 560.675232 cc
2025-04-22T16:47:10.711Z,1745340430.711 [Reporter](INFO): platform_buoyancy_position 556.243347 cc
2025-04-22T16:47:11.124Z,1745340431.124 [Reporter](INFO): platform_buoyancy_position 549.931274 cc
2025-04-22T16:47:11.492Z,1745340431.492 [Reporter](INFO): platform_buoyancy_position 545.633667 cc
2025-04-22T16:47:11.918Z,1745340431.918 [Reporter](INFO): platform_buoyancy_position 540.127380 cc
2025-04-22T16:47:12.328Z,1745340432.328 [Reporter](INFO): platform_buoyancy_position 534.755371 cc
2025-04-22T16:47:12.723Z,1745340432.723 [Reporter](INFO): platform_buoyancy_position 528.443237 cc
2025-04-22T16:47:13.112Z,1745340433.112 [Reporter](INFO): platform_buoyancy_position 524.145630 cc
2025-04-22T16:47:13.534Z,1745340433.534 [Reporter](INFO): platform_buoyancy_position 519.445129 cc
2025-04-22T16:47:13.949Z,1745340433.949 [Reporter](INFO): platform_buoyancy_position 513.401672 cc
2025-04-22T16:47:14.316Z,1745340434.316 [Reporter](INFO): platform_buoyancy_position 508.969696 cc
2025-04-22T16:47:14.725Z,1745340434.725 [Reporter](INFO): platform_buoyancy_position 502.523376 cc
2025-04-22T16:47:15.141Z,1745340435.141 [Reporter](INFO): platform_buoyancy_position 498.225800 cc
2025-04-22T16:47:15.579Z,1745340435.579 [Reporter](INFO): platform_buoyancy_position 491.913635 cc
2025-04-22T16:47:15.988Z,1745340435.988 [Reporter](INFO): platform_buoyancy_position 487.616028 cc
2025-04-22T16:47:16.368Z,1745340436.368 [Reporter](INFO): platform_buoyancy_position 481.169678 cc
2025-04-22T16:47:16.768Z,1745340436.768 [Reporter](INFO): platform_buoyancy_position 476.737732 cc
2025-04-22T16:47:17.197Z,1745340437.197 [Reporter](INFO): platform_buoyancy_position 470.291321 cc
2025-04-22T16:47:17.594Z,1745340437.594 [Reporter](INFO): platform_buoyancy_position 465.993774 cc
2025-04-22T16:47:18.044Z,1745340438.044 [Reporter](INFO): platform_buoyancy_position 459.547363 cc
2025-04-22T16:47:18.396Z,1745340438.396 [Reporter](INFO): platform_buoyancy_position 455.249756 cc
2025-04-22T16:47:18.808Z,1745340438.808 [Reporter](INFO): platform_buoyancy_position 448.937622 cc
2025-04-22T16:47:19.188Z,1745340439.188 [Reporter](INFO): platform_buoyancy_position 444.640076 cc
2025-04-22T16:47:19.602Z,1745340439.602 [Reporter](INFO): platform_buoyancy_position 440.208130 cc
2025-04-22T16:47:20.004Z,1745340440.004 [Reporter](INFO): platform_buoyancy_position 433.761719 cc
2025-04-22T16:47:20.384Z,1745340440.384 [Reporter](INFO): platform_buoyancy_position 429.598450 cc
2025-04-22T16:47:20.807Z,1745340440.807 [Reporter](INFO): platform_buoyancy_position 423.152039 cc
2025-04-22T16:47:21.219Z,1745340441.219 [Reporter](INFO): platform_buoyancy_position 418.585815 cc
2025-04-22T16:47:21.592Z,1745340441.592 [Reporter](INFO): platform_buoyancy_position 412.542358 cc
2025-04-22T16:47:22.004Z,1745340442.004 [Reporter](INFO): platform_buoyancy_position 407.976135 cc
2025-04-22T16:47:22.420Z,1745340442.420 [Reporter](INFO): platform_buoyancy_position 401.798340 cc
2025-04-22T16:47:22.800Z,1745340442.800 [Reporter](INFO): platform_buoyancy_position 397.232117 cc
2025-04-22T16:47:23.215Z,1745340443.215 [Reporter](INFO): platform_buoyancy_position 391.322937 cc
2025-04-22T16:47:23.620Z,1745340443.620 [Reporter](INFO): platform_buoyancy_position 386.622437 cc
2025-04-22T16:47:24.040Z,1745340444.040 [Reporter](INFO): platform_buoyancy_position 380.310364 cc
2025-04-22T16:47:24.440Z,1745340444.440 [Reporter](INFO): platform_buoyancy_position 375.878418 cc
2025-04-22T16:47:24.830Z,1745340444.830 [Reporter](INFO): platform_buoyancy_position 371.177917 cc
2025-04-22T16:47:25.243Z,1745340445.243 [Reporter](INFO): platform_buoyancy_position 365.134460 cc
2025-04-22T16:47:25.656Z,1745340445.656 [Reporter](INFO): platform_buoyancy_position 360.702515 cc
2025-04-22T16:47:26.162Z,1745340446.162 [Reporter](INFO): platform_buoyancy_position 354.256165 cc
2025-04-22T16:47:26.599Z,1745340446.599 [Reporter](INFO): platform_buoyancy_position 349.958557 cc
2025-04-22T16:47:26.902Z,1745340446.902 [Reporter](INFO): platform_buoyancy_position 343.646423 cc
2025-04-22T16:47:27.392Z,1745340447.392 [Reporter](INFO): platform_buoyancy_position 339.214539 cc
2025-04-22T16:47:27.676Z,1745340447.676 [Reporter](INFO): platform_buoyancy_position 332.902466 cc
2025-04-22T16:47:28.060Z,1745340448.060 [Reporter](INFO): platform_buoyancy_position 328.470520 cc
2025-04-22T16:47:28.478Z,1745340448.478 [Reporter](INFO): platform_buoyancy_position 322.024109 cc
2025-04-22T16:47:28.887Z,1745340448.887 [Reporter](INFO): platform_buoyancy_position 317.726562 cc
2025-04-22T16:47:29.271Z,1745340449.271 [Reporter](INFO): platform_buoyancy_position 312.623108 cc
2025-04-22T16:47:29.684Z,1745340449.684 [Reporter](INFO): platform_buoyancy_position 306.982544 cc
2025-04-22T16:47:30.200Z,1745340450.200 [Reporter](INFO): platform_buoyancy_position 300.670441 cc
2025-04-22T16:47:30.663Z,1745340450.663 [Reporter](INFO): platform_buoyancy_position 296.372833 cc
2025-04-22T16:47:30.908Z,1745340450.908 [Reporter](INFO): platform_buoyancy_position 291.538025 cc
2025-04-22T16:47:31.428Z,1745340451.428 [Reporter](INFO): platform_buoyancy_position 285.628845 cc
2025-04-22T16:47:31.731Z,1745340451.731 [Reporter](INFO): platform_buoyancy_position 281.062622 cc
2025-04-22T16:47:32.231Z,1745340452.231 [Reporter](INFO): platform_buoyancy_position 275.287720 cc
2025-04-22T16:47:32.503Z,1745340452.503 [Reporter](INFO): platform_buoyancy_position 270.452942 cc
2025-04-22T16:47:32.938Z,1745340452.938 [Reporter](INFO): platform_buoyancy_position 264.275146 cc
2025-04-22T16:47:33.319Z,1745340453.319 [Reporter](INFO): platform_buoyancy_position 259.708923 cc
2025-04-22T16:47:33.735Z,1745340453.735 [Reporter](INFO): platform_buoyancy_position 253.396805 cc
2025-04-22T16:47:34.112Z,1745340454.112 [Reporter](INFO): platform_buoyancy_position 249.099243 cc
2025-04-22T16:47:34.524Z,1745340454.524 [Reporter](INFO): platform_buoyancy_position 242.652832 cc
2025-04-22T16:47:34.994Z,1745340454.994 [Reporter](INFO): platform_buoyancy_position 237.952332 cc
2025-04-22T16:47:35.363Z,1745340455.363 [Reporter](INFO): platform_buoyancy_position 232.177429 cc
2025-04-22T16:47:35.760Z,1745340455.760 [Reporter](INFO): platform_buoyancy_position 227.476929 cc
2025-04-22T16:47:36.144Z,1745340456.144 [Reporter](INFO): platform_buoyancy_position 221.299133 cc
2025-04-22T16:47:36.683Z,1745340456.683 [Reporter](INFO): platform_buoyancy_position 216.732941 cc
2025-04-22T16:47:37.107Z,1745340457.107 [Reporter](INFO): platform_buoyancy_position 212.435333 cc
2025-04-22T16:47:37.387Z,1745340457.387 [Reporter](INFO): platform_buoyancy_position 206.123230 cc
2025-04-22T16:47:37.794Z,1745340457.794 [Reporter](INFO): platform_buoyancy_position 201.691315 cc
2025-04-22T16:47:38.295Z,1745340458.295 [Reporter](INFO): platform_buoyancy_position 195.379242 cc
2025-04-22T16:47:38.580Z,1745340458.580 [Reporter](INFO): platform_buoyancy_position 190.947327 cc
2025-04-22T16:47:38.992Z,1745340458.992 [Reporter](INFO): platform_buoyancy_position 184.635223 cc
2025-04-22T16:47:39.388Z,1745340459.388 [Reporter](INFO): platform_buoyancy_position 180.203339 cc
2025-04-22T16:47:39.788Z,1745340459.788 [Reporter](INFO): platform_buoyancy_position 173.891235 cc
2025-04-22T16:47:40.203Z,1745340460.203 [Reporter](INFO): platform_buoyancy_position 169.459320 cc
2025-04-22T16:47:40.580Z,1745340460.580 [Reporter](INFO): platform_buoyancy_position 163.012939 cc
2025-04-22T16:47:40.992Z,1745340460.992 [Reporter](INFO): platform_buoyancy_position 158.849640 cc
2025-04-22T16:47:41.405Z,1745340461.405 [Reporter](INFO): platform_buoyancy_position 152.403229 cc
2025-04-22T16:47:41.805Z,1745340461.805 [Reporter](INFO): platform_buoyancy_position 148.105621 cc
2025-04-22T16:47:42.221Z,1745340462.221 [Reporter](INFO): platform_buoyancy_position 143.539429 cc
2025-04-22T16:47:42.608Z,1745340462.608 [Reporter](INFO): platform_buoyancy_position 137.361633 cc
2025-04-22T16:47:43.021Z,1745340463.021 [Reporter](INFO): platform_buoyancy_position 132.929718 cc
2025-04-22T16:47:43.434Z,1745340463.434 [Reporter](INFO): platform_buoyancy_position 126.483337 cc
2025-04-22T16:47:43.816Z,1745340463.816 [Reporter](INFO): platform_buoyancy_position 122.185722 cc
2025-04-22T16:47:44.228Z,1745340464.228 [Reporter](INFO): platform_buoyancy_position 116.410828 cc
2025-04-22T16:47:44.651Z,1745340464.651 [Reporter](INFO): platform_buoyancy_position 111.576019 cc
2025-04-22T16:47:45.020Z,1745340465.020 [Reporter](INFO): platform_buoyancy_position 107.278412 cc
2025-04-22T16:47:45.445Z,1745340465.445 [Reporter](INFO): platform_buoyancy_position 100.832031 cc
2025-04-22T16:47:45.857Z,1745340465.857 [Reporter](INFO): platform_buoyancy_position 95.728607 cc
2025-04-22T16:47:46.369Z,1745340466.369 [Reporter](INFO): platform_buoyancy_position 89.953735 cc
2025-04-22T16:48:19.257Z,1745340499.257 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-22T16:48:21.265Z,1745340501.265 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239277
2025-04-22T16:48:54.422Z,1745340534.422 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-22T16:48:58.438Z,1745340538.438 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2025-04-22T16:48:58.709Z,1745340538.709 [Radio_Surface](INFO): Powering down
2025-04-22T16:52:21.251Z,1745340741.251 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T16:52:21.252Z,1745340741.252 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T16:52:21.252Z,1745340741.252 [Waterlinked](ERROR): Communications Fault
2025-04-22T16:52:21.488Z,1745340741.488 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T16:52:21.685Z,1745340741.685 [Waterlinked](INFO): Powering down
2025-04-22T16:52:22.376Z,1745340742.376 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T16:52:22.376Z,1745340742.376 [Waterlinked] No Fault, FailCount= 1
2025-04-22T16:53:21.860Z,1745340801.860 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T16:53:21.860Z,1745340801.860 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T16:53:21.860Z,1745340801.860 [Waterlinked](ERROR): Communications Fault
2025-04-22T16:53:22.006Z,1745340802.006 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T16:53:22.333Z,1745340802.333 [Waterlinked](INFO): Powering down
2025-04-22T16:53:23.005Z,1745340803.005 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T16:53:23.005Z,1745340803.005 [Waterlinked] No Fault, FailCount= 1
2025-04-22T16:54:10.534Z,1745340850.534 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T16:54:10.535Z,1745340850.535 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T16:54:10.535Z,1745340850.535 [Waterlinked](ERROR): Communications Fault
2025-04-22T16:54:10.725Z,1745340850.725 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T16:54:10.985Z,1745340850.985 [Waterlinked](INFO): Powering down
2025-04-22T16:54:11.708Z,1745340851.708 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T16:54:11.708Z,1745340851.708 [Waterlinked] No Fault, FailCount= 1
2025-04-22T16:55:56.197Z,1745340956.197 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T16:55:56.197Z,1745340956.197 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T16:55:56.198Z,1745340956.198 [Waterlinked](ERROR): Communications Fault
2025-04-22T16:55:56.553Z,1745340956.553 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T16:55:56.777Z,1745340956.777 [Waterlinked](INFO): Powering down
2025-04-22T16:55:57.466Z,1745340957.466 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T16:55:57.466Z,1745340957.466 [Waterlinked] No Fault, FailCount= 1
2025-04-22T16:56:35.868Z,1745340995.868 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T16:56:35.869Z,1745340995.869 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T16:56:35.869Z,1745340995.869 [Waterlinked](ERROR): Communications Fault
2025-04-22T16:56:36.075Z,1745340996.075 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T16:56:36.325Z,1745340996.325 [Waterlinked](INFO): Powering down
2025-04-22T16:56:37.047Z,1745340997.047 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T16:56:37.047Z,1745340997.047 [Waterlinked] No Fault, FailCount= 1
2025-04-22T16:57:23.587Z,1745341043.587 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T16:57:23.588Z,1745341043.588 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T16:57:23.588Z,1745341043.588 [Waterlinked](ERROR): Communications Fault
2025-04-22T16:57:23.755Z,1745341043.755 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T16:57:24.005Z,1745341044.005 [Waterlinked](INFO): Powering down
2025-04-22T16:57:24.734Z,1745341044.734 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T16:57:24.734Z,1745341044.734 [Waterlinked] No Fault, FailCount= 1
2025-04-22T16:58:13.295Z,1745341093.295 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T16:58:13.295Z,1745341093.295 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T16:58:13.295Z,1745341093.295 [Waterlinked](ERROR): Communications Fault
2025-04-22T16:58:13.513Z,1745341093.513 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T16:58:13.801Z,1745341093.801 [Waterlinked](INFO): Powering down
2025-04-22T16:58:14.451Z,1745341094.451 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T16:58:14.451Z,1745341094.451 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:00:00.036Z,1745341200.036 [CommandExec](IMPORTANT): got command gfisolate
2025-04-22T17:00:00.402Z,1745341200.402 [GFScanner](INFO): Ground fault isolation requested
2025-04-22T17:00:00.402Z,1745341200.402 [GFScanner](IMPORTANT): Starting ground fault isolation process
2025-04-22T17:00:00.403Z,1745341200.403 [GFScanner](IMPORTANT): No ground fault detected in recent scan results, will request new scan
2025-04-22T17:00:00.754Z,1745341200.754 [GFScanner](INFO): Requesting scan for ground fault isolation
2025-04-22T17:00:00.754Z,1745341200.754 [GFScanner](INFO): Beginning ground fault scan
2025-04-22T17:00:01.106Z,1745341201.106 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2025-04-22T17:00:01.111Z,1745341201.111 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-22T17:00:02.109Z,1745341202.109 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2025-04-22T17:00:02.112Z,1745341202.112 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-22T17:00:03.115Z,1745341203.115 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2025-04-22T17:00:03.118Z,1745341203.118 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-22T17:00:04.117Z,1745341204.117 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2025-04-22T17:00:04.120Z,1745341204.120 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-22T17:00:05.122Z,1745341205.122 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2025-04-22T17:00:05.125Z,1745341205.125 [CTD_Seabird](INFO): some bad data, not updating bins
2025-04-22T17:00:05.578Z,1745341205.578 [GFScanner](INFO): No ground fault detected
mA:
CHAN A0 (Batt): -0.006412
CHAN A1 (24V): -0.003896
CHAN A2 (12V): -0.005205
CHAN A3 (5V): -0.002875
CHAN B0 (3.3V): -0.000424
CHAN B1 (3.15aV): -0.001067
CHAN B2 (3.15bV): -0.001138
CHAN B3 (GND): -0.001218
OPEN: 0.006033
Full Scale: +/- 1 mA
2025-04-22T17:00:06.054Z,1745341206.054 [GFScanner](IMPORTANT): No ground fault detected in initial scan, completing isolation process
2025-04-22T17:00:06.386Z,1745341206.386 [GFScanner](IMPORTANT): Ground fault isolation process complete
2025-04-22T17:00:17.903Z,1745341217.903 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:00:17.903Z,1745341217.903 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:00:17.903Z,1745341217.903 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:00:18.050Z,1745341218.050 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:00:18.349Z,1745341218.349 [Waterlinked](INFO): Powering down
2025-04-22T17:00:19.062Z,1745341219.062 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:00:19.062Z,1745341219.062 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:01:43.718Z,1745341303.718 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:01:43.718Z,1745341303.718 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:01:43.718Z,1745341303.718 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:01:43.925Z,1745341303.925 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:01:44.149Z,1745341304.149 [Waterlinked](INFO): Powering down
2025-04-22T17:01:44.833Z,1745341304.833 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:01:44.833Z,1745341304.833 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:03:18.498Z,1745341398.498 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:03:18.498Z,1745341398.498 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:03:18.498Z,1745341398.498 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:03:18.738Z,1745341398.738 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:03:18.985Z,1745341398.985 [Waterlinked](INFO): Powering down
2025-04-22T17:03:19.691Z,1745341399.691 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:03:19.691Z,1745341399.691 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:04:16.871Z,1745341456.871 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:04:16.871Z,1745341456.871 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:04:16.871Z,1745341456.871 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:04:17.028Z,1745341457.028 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:04:17.357Z,1745341457.357 [Waterlinked](INFO): Powering down
2025-04-22T17:04:18.069Z,1745341458.069 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:04:18.069Z,1745341458.069 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:05:30.448Z,1745341530.448 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:05:30.449Z,1745341530.449 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:05:30.449Z,1745341530.449 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:05:30.638Z,1745341530.638 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:05:30.909Z,1745341530.909 [Waterlinked](INFO): Powering down
2025-04-22T17:05:31.625Z,1745341531.625 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:05:31.625Z,1745341531.625 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:07:40.203Z,1745341660.203 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:07:40.204Z,1745341660.204 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:07:40.204Z,1745341660.204 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:07:40.374Z,1745341660.374 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:07:40.661Z,1745341660.661 [Waterlinked](INFO): Powering down
2025-04-22T17:07:41.373Z,1745341661.373 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:07:41.373Z,1745341661.373 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:08:27.539Z,1745341707.539 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:08:27.540Z,1745341707.540 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:08:27.540Z,1745341707.540 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:08:27.697Z,1745341707.697 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:08:27.989Z,1745341707.989 [Waterlinked](INFO): Powering down
2025-04-22T17:08:28.694Z,1745341708.694 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:08:28.694Z,1745341708.694 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:09:35.995Z,1745341775.995 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:09:35.995Z,1745341775.995 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:09:35.996Z,1745341775.996 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:09:36.141Z,1745341776.141 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:09:36.413Z,1745341776.413 [Waterlinked](INFO): Powering down
2025-04-22T17:09:37.095Z,1745341777.095 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:09:37.095Z,1745341777.095 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:10:16.434Z,1745341816.434 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:10:16.434Z,1745341816.434 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:10:16.434Z,1745341816.434 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:10:16.596Z,1745341816.596 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:10:16.865Z,1745341816.865 [Waterlinked](INFO): Powering down
2025-04-22T17:10:17.556Z,1745341817.556 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:10:17.557Z,1745341817.557 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:11:12.641Z,1745341872.641 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:11:12.641Z,1745341872.641 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:11:12.642Z,1745341872.642 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:11:12.802Z,1745341872.802 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:11:13.105Z,1745341873.105 [Waterlinked](INFO): Powering down
2025-04-22T17:11:13.810Z,1745341873.810 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:11:13.810Z,1745341873.810 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:12:08.490Z,1745341928.490 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:12:08.490Z,1745341928.490 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:12:08.490Z,1745341928.490 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:12:08.651Z,1745341928.651 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:12:08.933Z,1745341928.933 [Waterlinked](INFO): Powering down
2025-04-22T17:12:09.666Z,1745341929.666 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:12:09.667Z,1745341929.667 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:13:24.541Z,1745342004.541 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:13:24.870Z,1745342004.870 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:13:31.452Z,1745342011.452 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:13:40.057Z,1745342020.057 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:13:46.855Z,1745342026.855 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:13:55.062Z,1745342035.062 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:13:55.062Z,1745342035.062 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:13:55.062Z,1745342035.062 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:13:55.232Z,1745342035.232 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:13:55.356Z,1745342035.356 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:13:55.497Z,1745342035.497 [Waterlinked](INFO): Powering down
2025-04-22T17:13:56.157Z,1745342036.157 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:13:56.157Z,1745342036.157 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:14:02.169Z,1745342042.169 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:14:05.024Z,1745342045.024 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2025-04-22T17:14:05.024Z,1745342045.024 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2025-04-22T17:14:05.042Z,1745342045.042 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2025-04-22T17:14:05.425Z,1745342045.425 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2025-04-22T17:14:05.426Z,1745342045.426 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2025-04-22T17:14:09.846Z,1745342049.846 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:14:17.926Z,1745342057.926 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:14:25.377Z,1745342065.377 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:14:33.146Z,1745342073.146 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:14:38.074Z,1745342078.074 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:14:38.075Z,1745342078.075 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:14:38.075Z,1745342078.075 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:14:38.228Z,1745342078.228 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:14:38.502Z,1745342078.502 [Waterlinked](INFO): Powering down
2025-04-22T17:14:39.214Z,1745342079.214 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:14:39.214Z,1745342079.214 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:14:41.188Z,1745342081.188 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:14:48.460Z,1745342088.460 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:14:56.139Z,1745342096.139 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:15:03.410Z,1745342103.410 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:15:11.276Z,1745342111.276 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:15:18.930Z,1745342118.930 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:15:26.210Z,1745342126.210 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:15:34.139Z,1745342134.139 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2025-04-22T17:15:41.431Z,1745342141.431 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2025-04-22T17:15:48.074Z,1745342148.074 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:15:48.074Z,1745342148.074 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:15:48.074Z,1745342148.074 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:15:48.262Z,1745342148.262 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:15:48.414Z,1745342148.414 [BPC1](INFO): Calculating totals. Valid battery stick count: 46. Valid reserve battery stick count: 5.
2025-04-22T17:15:48.420Z,1745342148.420 [BPC1](INFO): Received data from all battery sticks.
2025-04-22T17:15:48.533Z,1745342148.533 [Waterlinked](INFO): Powering down
2025-04-22T17:15:49.150Z,1745342149.150 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:15:49.150Z,1745342149.150 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:16:34.048Z,1745342194.048 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:16:34.050Z,1745342194.050 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:16:34.050Z,1745342194.050 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:16:34.190Z,1745342194.190 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:16:34.537Z,1745342194.537 [Waterlinked](INFO): Powering down
2025-04-22T17:16:35.190Z,1745342195.190 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:16:35.190Z,1745342195.190 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:17:18.915Z,1745342238.915 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:17:18.916Z,1745342238.916 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:17:18.916Z,1745342238.916 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:17:19.047Z,1745342239.047 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:17:19.329Z,1745342239.329 [Waterlinked](INFO): Powering down
2025-04-22T17:17:20.045Z,1745342240.045 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:17:20.045Z,1745342240.045 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:18:41.126Z,1745342321.126 [Waterlinked](ERROR): No DVL communication! Re-initializing
2025-04-22T17:18:41.126Z,1745342321.126 [Waterlinked] Communications Fault, FailCount= 1
2025-04-22T17:18:41.126Z,1745342321.126 [Waterlinked](ERROR): Communications Fault
2025-04-22T17:18:41.419Z,1745342321.419 [CBIT](ERROR): Communications Fault in component: Waterlinked
2025-04-22T17:18:41.585Z,1745342321.585 [Waterlinked](INFO): Powering down
2025-04-22T17:18:42.285Z,1745342322.285 [CBIT](INFO): Clearing failed state for component Waterlinked
2025-04-22T17:18:42.285Z,1745342322.285 [Waterlinked] No Fault, FailCount= 1
2025-04-22T17:20:01.377Z,1745342401.377 [Radio_Surface](INFO): Powering up
2025-04-22T17:20:07.205Z,1745342407.205 [DataOverHttps](INFO): Radio surface powered ON.
2025-04-22T17:20:37.350Z,1745342437.350 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-22T17:21:12.493Z,1745342472.493 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-22T17:21:47.638Z,1745342507.638 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-22T17:22:22.783Z,1745342542.783 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-22T17:22:27.884Z,1745342547.884 [sink:RunSink](INFO): Timed out from 2025-04-22T16:46:27.4Z
2025-04-22T17:22:27.884Z,1745342547.884 [sink:RunSink] Stopped
2025-04-22T17:22:27.884Z,1745342547.884 [sink:RunSink](DEBUG): Aggregate::uninitialize sink:RunSink
2025-04-22T17:22:27.884Z,1745342547.884 [sink:RunSink:BallastAndTrim] Stopped
2025-04-22T17:22:27.884Z,1745342547.884 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim
2025-04-22T17:22:27.884Z,1745342547.884 [sink:RunSink:BallastAndTrim:A] Stopped
2025-04-22T17:22:27.885Z,1745342547.885 [sink:RunSink:BallastAndTrim:B] Stopped
2025-04-22T17:22:27.885Z,1745342547.885 [sink:RunSink:BallastAndTrim:C] Stopped
2025-04-22T17:22:27.885Z,1745342547.885 [sink:RunSink:BallastAndTrim:D] Stopped
2025-04-22T17:22:27.885Z,1745342547.885 [sink:RunSink:BallastAndTrim:E] Stopped
2025-04-22T17:22:27.885Z,1745342547.885 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Stopped
2025-04-22T17:22:27.885Z,1745342547.885 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Stopped
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Stopped
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Stopped
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Uninitialize.
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Stopped
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:JustSink] Stopped
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:JustSink](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:JustSink:C] Stopped
2025-04-22T17:22:27.886Z,1745342547.886 [sink:RunSink:JustSink:C](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink:C
2025-04-22T17:22:27.887Z,1745342547.887 [sink:FloatUp] Running Loop=1
2025-04-22T17:22:27.887Z,1745342547.887 [sink:FloatUp](DEBUG): Aggregate::initialize sink:FloatUp
2025-04-22T17:22:27.887Z,1745342547.887 [sink:FloatUp:A.Buoyancy] Running Loop=1
2025-04-22T17:22:27.887Z,1745342547.887 [sink:FloatUp:A.Buoyancy](DEBUG): Initialize Buoyancy Component.
2025-04-22T17:22:27.887Z,1745342547.887 [sink:FloatUp:B.Wait] Running Loop=1
2025-04-22T17:22:27.887Z,1745342547.887 [sink:FloatUp:B.Wait](DEBUG): Initialize Wait Component.
2025-04-22T17:22:28.242Z,1745342548.242 [sink:FloatUp] Stopped
2025-04-22T17:22:28.242Z,1745342548.242 [sink:FloatUp](DEBUG): Aggregate::uninitialize sink:FloatUp
2025-04-22T17:22:28.242Z,1745342548.242 [sink:FloatUp:A.Buoyancy] Stopped
2025-04-22T17:22:28.242Z,1745342548.242 [sink:FloatUp:A.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2025-04-22T17:22:28.242Z,1745342548.242 [sink:FloatUp:B.Wait] Stopped
2025-04-22T17:22:28.242Z,1745342548.242 [sink:FloatUp:B.Wait](DEBUG): Uninitialize Wait Component.
2025-04-22T17:22:28.242Z,1745342548.242 [sink:EndingMission] Running Loop=1
2025-04-22T17:22:28.242Z,1745342548.242 [sink:EndingMission](DEBUG): Aggregate::initialize sink:EndingMission
2025-04-22T17:22:28.662Z,1745342548.662 [sink:NeedComms] Running Loop=1
2025-04-22T17:22:28.663Z,1745342548.663 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms
2025-04-22T17:22:28.663Z,1745342548.663 [sink:NeedComms:B.GoToSurface] Running Loop=1
2025-04-22T17:22:28.663Z,1745342548.663 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-22T17:22:28.663Z,1745342548.663 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2025-04-22T17:22:28.663Z,1745342548.663 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2025-04-22T17:22:28.664Z,1745342548.664 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2025-04-22T17:22:28.664Z,1745342548.664 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds.
2025-04-22T17:22:28.665Z,1745342548.665 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-22T17:22:28.665Z,1745342548.665 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-22T17:22:28.665Z,1745342548.665 [sink:NeedComms:A] Running Loop=1
2025-04-22T17:22:28.667Z,1745342548.667 [sink:NeedComms:A](INFO): last time_fix was: 1745340386.000000 second since 1970/01/01T00:00:00Z
2025-04-22T17:22:28.667Z,1745342548.667 [sink:NeedComms:A] Stopped
2025-04-22T17:22:29.059Z,1745342549.059 [sink:NeedComms:C] Running Loop=1
2025-04-22T17:22:29.732Z,1745342549.732 [Reporter](INFO): platform_buoyancy_position 81.492828 cc
2025-04-22T17:22:30.074Z,1745342550.074 [Reporter](INFO): platform_buoyancy_position 83.238708 cc
2025-04-22T17:22:30.330Z,1745342550.330 [Reporter](INFO): platform_buoyancy_position 83.507324 cc
2025-04-22T17:22:30.747Z,1745342550.747 [Reporter](INFO): platform_buoyancy_position 85.656128 cc
2025-04-22T17:22:30.981Z,1745342550.981 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172230.00,A,3648.16692,N,12147.28432,W,0.058,0.00,220425,,,A*7A
2025-04-22T17:22:30.983Z,1745342550.983 [NAL9602](INFO): GPS fix at 20250422T172230: (36.802782, -121.788072)
2025-04-22T17:22:31.058Z,1745342551.058 [sink:NeedComms:C] Stopped
2025-04-22T17:22:31.059Z,1745342551.059 [sink:NeedComms:D] Running Loop=1
2025-04-22T17:22:31.297Z,1745342551.297 [Reporter](INFO): platform_buoyancy_position 90.490936 cc
2025-04-22T17:22:31.615Z,1745342551.615 [Reporter](INFO): platform_buoyancy_position 94.519928 cc
2025-04-22T17:22:32.102Z,1745342552.102 [Reporter](INFO): platform_buoyancy_position 102.846527 cc
2025-04-22T17:22:32.583Z,1745342552.583 [Reporter](INFO): platform_buoyancy_position 109.292908 cc
2025-04-22T17:22:32.976Z,1745342552.976 [Reporter](INFO): platform_buoyancy_position 113.590515 cc
2025-04-22T17:22:33.367Z,1745342553.367 [Reporter](INFO): platform_buoyancy_position 118.156738 cc
2025-04-22T17:22:33.763Z,1745342553.763 [Reporter](INFO): platform_buoyancy_position 124.334534 cc
2025-04-22T17:22:34.190Z,1745342554.190 [Reporter](INFO): platform_buoyancy_position 128.766418 cc
2025-04-22T17:22:34.589Z,1745342554.589 [Reporter](INFO): platform_buoyancy_position 135.078522 cc
2025-04-22T17:22:35.141Z,1745342555.141 [Reporter](INFO): platform_buoyancy_position 141.793518 cc
2025-04-22T17:22:35.343Z,1745342555.343 [Reporter](INFO): platform_buoyancy_position 145.822540 cc
2025-04-22T17:22:35.739Z,1745342555.739 [Reporter](INFO): platform_buoyancy_position 150.254425 cc
2025-04-22T17:22:36.152Z,1745342556.152 [Reporter](INFO): platform_buoyancy_position 154.686340 cc
2025-04-22T17:22:36.536Z,1745342556.536 [Reporter](INFO): platform_buoyancy_position 160.864136 cc
2025-04-22T17:22:36.975Z,1745342556.975 [Reporter](INFO): platform_buoyancy_position 167.310516 cc
2025-04-22T17:22:37.423Z,1745342557.423 [Reporter](INFO): platform_buoyancy_position 171.876740 cc
2025-04-22T17:22:37.724Z,1745342557.724 [Reporter](INFO): platform_buoyancy_position 176.040039 cc
2025-04-22T17:22:38.249Z,1745342558.249 [Reporter](INFO): platform_buoyancy_position 182.352142 cc
2025-04-22T17:22:38.629Z,1745342558.629 [Reporter](INFO): platform_buoyancy_position 188.798523 cc
2025-04-22T17:22:39.064Z,1745342559.064 [Reporter](INFO): platform_buoyancy_position 193.364716 cc
2025-04-22T17:22:39.436Z,1745342559.436 [Reporter](INFO): platform_buoyancy_position 198.199524 cc
2025-04-22T17:22:40.016Z,1745342560.016 [Reporter](INFO): platform_buoyancy_position 204.914520 cc
2025-04-22T17:22:40.229Z,1745342560.229 [Reporter](INFO): platform_buoyancy_position 208.943542 cc
2025-04-22T17:22:40.578Z,1745342560.578 [Reporter](INFO): platform_buoyancy_position 214.718445 cc
2025-04-22T17:22:41.020Z,1745342561.020 [Reporter](INFO): platform_buoyancy_position 219.284637 cc
2025-04-22T17:22:41.347Z,1745342561.347 [Reporter](INFO): platform_buoyancy_position 224.253723 cc
2025-04-22T17:22:41.727Z,1745342561.727 [Reporter](INFO): platform_buoyancy_position 229.625732 cc
2025-04-22T17:22:42.216Z,1745342562.216 [Reporter](INFO): platform_buoyancy_position 236.072144 cc
2025-04-22T17:22:42.644Z,1745342562.644 [Reporter](INFO): platform_buoyancy_position 241.847046 cc
2025-04-22T17:22:43.064Z,1745342563.064 [Reporter](INFO): platform_buoyancy_position 246.816147 cc
2025-04-22T17:22:43.431Z,1745342563.431 [Reporter](INFO): platform_buoyancy_position 251.248047 cc
2025-04-22T17:22:43.887Z,1745342563.887 [Reporter](INFO): platform_buoyancy_position 257.560120 cc
2025-04-22T17:22:44.230Z,1745342564.230 [Reporter](INFO): platform_buoyancy_position 262.126343 cc
2025-04-22T17:22:44.628Z,1745342564.628 [Reporter](INFO): platform_buoyancy_position 268.304138 cc
2025-04-22T17:22:45.032Z,1745342565.032 [Reporter](INFO): platform_buoyancy_position 272.870331 cc
2025-04-22T17:22:45.424Z,1745342565.424 [Reporter](INFO): platform_buoyancy_position 277.033630 cc
2025-04-22T17:22:45.855Z,1745342565.855 [Reporter](INFO): platform_buoyancy_position 283.614349 cc
2025-04-22T17:22:46.291Z,1745342566.291 [Reporter](INFO): platform_buoyancy_position 289.926422 cc
2025-04-22T17:22:46.591Z,1745342566.591 [Reporter](INFO): platform_buoyancy_position 292.343842 cc
2025-04-22T17:22:47.094Z,1745342567.094 [Reporter](INFO): platform_buoyancy_position 299.596039 cc
2025-04-22T17:22:47.487Z,1745342567.487 [Reporter](INFO): platform_buoyancy_position 305.102325 cc
2025-04-22T17:22:47.876Z,1745342567.876 [Reporter](INFO): platform_buoyancy_position 309.399933 cc
2025-04-22T17:22:48.252Z,1745342568.252 [Reporter](INFO): platform_buoyancy_position 315.577759 cc
2025-04-22T17:22:48.676Z,1745342568.676 [Reporter](INFO): platform_buoyancy_position 320.009644 cc
2025-04-22T17:22:49.111Z,1745342569.111 [Reporter](INFO): platform_buoyancy_position 326.321716 cc
2025-04-22T17:22:49.495Z,1745342569.495 [Reporter](INFO): platform_buoyancy_position 330.753662 cc
2025-04-22T17:22:49.887Z,1745342569.887 [Reporter](INFO): platform_buoyancy_position 335.722717 cc
2025-04-22T17:22:50.284Z,1745342570.284 [Reporter](INFO): platform_buoyancy_position 341.497620 cc
2025-04-22T17:22:50.688Z,1745342570.688 [Reporter](INFO): platform_buoyancy_position 345.929565 cc
2025-04-22T17:22:51.094Z,1745342571.094 [Reporter](INFO): platform_buoyancy_position 352.107361 cc
2025-04-22T17:22:51.487Z,1745342571.487 [Reporter](INFO): platform_buoyancy_position 356.404968 cc
2025-04-22T17:22:52.117Z,1745342572.117 [Reporter](INFO): platform_buoyancy_position 365.134460 cc
2025-04-22T17:22:52.384Z,1745342572.384 [Reporter](INFO): platform_buoyancy_position 369.297729 cc
2025-04-22T17:22:53.075Z,1745342573.075 [Reporter](INFO): platform_buoyancy_position 378.027222 cc
2025-04-22T17:22:53.196Z,1745342573.196 [Reporter](INFO): platform_buoyancy_position 379.907471 cc
2025-04-22T17:22:53.681Z,1745342573.681 [Reporter](INFO): platform_buoyancy_position 386.488159 cc
2025-04-22T17:22:54.062Z,1745342574.062 [Reporter](INFO): platform_buoyancy_position 390.920044 cc
2025-04-22T17:22:54.436Z,1745342574.436 [Reporter](INFO): platform_buoyancy_position 397.232117 cc
2025-04-22T17:22:54.975Z,1745342574.975 [Reporter](INFO): platform_buoyancy_position 401.664062 cc
2025-04-22T17:22:55.420Z,1745342575.420 [Reporter](INFO): platform_buoyancy_position 408.110474 cc
2025-04-22T17:22:55.646Z,1745342575.646 [Reporter](INFO): platform_buoyancy_position 412.408020 cc
2025-04-22T17:22:56.112Z,1745342576.112 [Reporter](INFO): platform_buoyancy_position 416.705627 cc
2025-04-22T17:22:56.466Z,1745342576.466 [Reporter](INFO): platform_buoyancy_position 423.017761 cc
2025-04-22T17:22:56.869Z,1745342576.869 [Reporter](INFO): platform_buoyancy_position 427.449646 cc
2025-04-22T17:22:57.260Z,1745342577.260 [Reporter](INFO): platform_buoyancy_position 432.015869 cc
2025-04-22T17:22:57.693Z,1745342577.693 [Reporter](INFO): platform_buoyancy_position 438.193665 cc
2025-04-22T17:22:57.921Z,1745342577.921 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2025-04-22T17:22:58.124Z,1745342578.124 [Reporter](INFO): platform_buoyancy_position 444.505737 cc
2025-04-22T17:22:58.531Z,1745342578.531 [Reporter](INFO): platform_buoyancy_position 448.937622 cc
2025-04-22T17:22:58.936Z,1745342578.936 [Reporter](INFO): platform_buoyancy_position 455.249756 cc
2025-04-22T17:22:59.316Z,1745342579.316 [Reporter](INFO): platform_buoyancy_position 459.547363 cc
2025-04-22T17:22:59.766Z,1745342579.766 [Reporter](INFO): platform_buoyancy_position 465.053650 cc
2025-04-22T17:23:00.122Z,1745342580.122 [Reporter](INFO): platform_buoyancy_position 470.425659 cc
2025-04-22T17:23:00.534Z,1745342580.534 [Reporter](INFO): platform_buoyancy_position 474.857544 cc
2025-04-22T17:23:00.943Z,1745342580.943 [Reporter](INFO): platform_buoyancy_position 481.035339 cc
2025-04-22T17:23:01.287Z,1745342581.287 [Reporter](INFO): platform_buoyancy_position 485.467224 cc
2025-04-22T17:23:01.582Z,1745342581.582 [NAL9602](ERROR): Queried for signal strength and failed to receive proper response.
2025-04-22T17:23:01.665Z,1745342581.665 [NAL9602](ERROR): received:
+CSQ:0
OK74, 2, 0, 0, 0
OK
2025-04-22T17:23:01.987Z,1745342581.987 [Reporter](INFO): platform_buoyancy_position 494.062439 cc
2025-04-22T17:23:02.259Z,1745342582.259 [Reporter](INFO): platform_buoyancy_position 498.225800 cc
2025-04-22T17:23:02.602Z,1745342582.602 [Reporter](INFO): platform_buoyancy_position 502.791962 cc
2025-04-22T17:23:03.235Z,1745342583.235 [Reporter](INFO): platform_buoyancy_position 511.252838 cc
2025-04-22T17:23:03.451Z,1745342583.451 [Reporter](INFO): platform_buoyancy_position 513.401672 cc
2025-04-22T17:23:04.116Z,1745342584.116 [Reporter](INFO): platform_buoyancy_position 524.011353 cc
2025-04-22T17:23:04.251Z,1745342584.251 [Reporter](INFO): platform_buoyancy_position 524.279968 cc
2025-04-22T17:23:04.702Z,1745342584.702 [Reporter](INFO): platform_buoyancy_position 530.592041 cc
2025-04-22T17:23:05.103Z,1745342585.103 [Reporter](INFO): platform_buoyancy_position 536.904175 cc
2025-04-22T17:23:05.472Z,1745342585.472 [Reporter](INFO): platform_buoyancy_position 541.201782 cc
2025-04-22T17:23:05.973Z,1745342585.973 [Reporter](INFO): platform_buoyancy_position 546.976685 cc
2025-04-22T17:23:06.332Z,1745342586.332 [Reporter](INFO): platform_buoyancy_position 551.945740 cc
2025-04-22T17:23:06.719Z,1745342586.719 [Reporter](INFO): platform_buoyancy_position 556.377686 cc
2025-04-22T17:23:07.114Z,1745342587.114 [Reporter](INFO): platform_buoyancy_position 562.689758 cc
2025-04-22T17:23:07.583Z,1745342587.583 [Reporter](INFO): platform_buoyancy_position 569.270447 cc
2025-04-22T17:23:07.996Z,1745342587.996 [Reporter](INFO): platform_buoyancy_position 573.568054 cc
2025-04-22T17:23:08.348Z,1745342588.348 [Reporter](INFO): platform_buoyancy_position 577.865662 cc
2025-04-22T17:23:08.763Z,1745342588.763 [Reporter](INFO): platform_buoyancy_position 584.177734 cc
2025-04-22T17:23:09.191Z,1745342589.191 [Reporter](INFO): platform_buoyancy_position 588.609680 cc
2025-04-22T17:23:09.570Z,1745342589.570 [Reporter](INFO): platform_buoyancy_position 594.921753 cc
2025-04-22T17:23:09.988Z,1745342589.988 [Reporter](INFO): platform_buoyancy_position 599.353638 cc
2025-04-22T17:23:10.359Z,1745342590.359 [Reporter](INFO): platform_buoyancy_position 605.665771 cc
2025-04-22T17:23:10.768Z,1745342590.768 [Reporter](INFO): platform_buoyancy_position 610.097656 cc
2025-04-22T17:23:11.172Z,1745342591.172 [Reporter](INFO): platform_buoyancy_position 616.409790 cc
2025-04-22T17:23:11.556Z,1745342591.556 [Reporter](INFO): platform_buoyancy_position 620.707336 cc
2025-04-22T17:23:11.909Z,1745342591.909 [Reporter](INFO): platform_buoyancy_position 625.004944 cc
2025-04-22T17:23:12.412Z,1745342592.412 [Reporter](INFO): platform_buoyancy_position 631.451355 cc
2025-04-22T17:23:12.780Z,1745342592.780 [Reporter](INFO): platform_buoyancy_position 635.883240 cc
2025-04-22T17:23:13.132Z,1745342593.132 [Reporter](INFO): platform_buoyancy_position 640.180847 cc
2025-04-22T17:23:13.566Z,1745342593.566 [Reporter](INFO): platform_buoyancy_position 646.627258 cc
2025-04-22T17:23:14.039Z,1745342594.039 [Reporter](INFO): platform_buoyancy_position 653.073669 cc
2025-04-22T17:23:14.431Z,1745342594.431 [Reporter](INFO): platform_buoyancy_position 657.774170 cc
2025-04-22T17:23:14.785Z,1745342594.785 [Reporter](INFO): platform_buoyancy_position 661.937439 cc
2025-04-22T17:23:15.223Z,1745342595.223 [Reporter](INFO): platform_buoyancy_position 668.115234 cc
2025-04-22T17:23:15.627Z,1745342595.627 [Reporter](INFO): platform_buoyancy_position 674.427368 cc
2025-04-22T17:23:16.006Z,1745342596.006 [Reporter](INFO): platform_buoyancy_position 678.724976 cc
2025-04-22T17:23:16.424Z,1745342596.424 [Reporter](INFO): platform_buoyancy_position 685.305664 cc
2025-04-22T17:23:16.796Z,1745342596.796 [Reporter](INFO): platform_buoyancy_position 689.468994 cc
2025-04-22T17:23:17.206Z,1745342597.206 [Reporter](INFO): platform_buoyancy_position 694.438049 cc
2025-04-22T17:23:17.611Z,1745342597.611 [Reporter](INFO): platform_buoyancy_position 700.212952 cc
2025-04-22T17:23:18.035Z,1745342598.035 [Reporter](INFO): platform_buoyancy_position 704.779175 cc
2025-04-22T17:23:18.492Z,1745342598.492 [Reporter](INFO): platform_buoyancy_position 711.359863 cc
2025-04-22T17:23:18.804Z,1745342598.804 [Reporter](INFO): platform_buoyancy_position 715.388855 cc
2025-04-22T17:23:19.240Z,1745342599.240 [Reporter](INFO): platform_buoyancy_position 721.835266 cc
2025-04-22T17:23:19.721Z,1745342599.721 [Reporter](INFO): platform_buoyancy_position 728.147339 cc
2025-04-22T17:23:20.065Z,1745342600.065 [Reporter](INFO): platform_buoyancy_position 732.579285 cc
2025-04-22T17:23:20.475Z,1745342600.475 [Reporter](INFO): platform_buoyancy_position 737.279785 cc
2025-04-22T17:23:20.878Z,1745342600.878 [Reporter](INFO): platform_buoyancy_position 743.323242 cc
2025-04-22T17:23:21.248Z,1745342601.248 [Reporter](INFO): platform_buoyancy_position 747.620850 cc
2025-04-22T17:23:21.672Z,1745342601.672 [Reporter](INFO): platform_buoyancy_position 753.932983 cc
2025-04-22T17:23:21.972Z,1745342601.972 [Reporter](INFO): platform_buoyancy_position 757.961975 cc
2025-04-22T17:23:22.435Z,1745342602.435 [Reporter](INFO): platform_buoyancy_position 762.796753 cc
2025-04-22T17:23:22.823Z,1745342602.823 [Reporter](INFO): platform_buoyancy_position 768.974548 cc
2025-04-22T17:23:23.256Z,1745342603.256 [Reporter](INFO): platform_buoyancy_position 773.272156 cc
2025-04-22T17:23:23.665Z,1745342603.665 [Reporter](INFO): platform_buoyancy_position 779.449951 cc
2025-04-22T17:23:24.143Z,1745342604.143 [Reporter](INFO): platform_buoyancy_position 786.164978 cc
2025-04-22T17:23:24.584Z,1745342604.584 [Reporter](INFO): platform_buoyancy_position 790.731201 cc
2025-04-22T17:23:24.839Z,1745342604.839 [Reporter](INFO): platform_buoyancy_position 794.760193 cc
2025-04-22T17:23:25.439Z,1745342605.439 [Reporter](INFO): platform_buoyancy_position 801.340881 cc
2025-04-22T17:23:25.767Z,1745342605.767 [Reporter](INFO): platform_buoyancy_position 807.652954 cc
2025-04-22T17:23:26.247Z,1745342606.247 [Reporter](INFO): platform_buoyancy_position 814.099365 cc
2025-04-22T17:23:26.763Z,1745342606.763 [Reporter](INFO): platform_buoyancy_position 820.545776 cc
2025-04-22T17:23:27.056Z,1745342607.056 [Reporter](INFO): platform_buoyancy_position 824.977661 cc
2025-04-22T17:23:27.472Z,1745342607.472 [Reporter](INFO): platform_buoyancy_position 829.275269 cc
2025-04-22T17:23:27.789Z,1745342607.789 [Reporter](INFO): platform_buoyancy_position 833.572876 cc
2025-04-22T17:23:28.232Z,1745342608.232 [Reporter](INFO): platform_buoyancy_position 839.885010 cc
2025-04-22T17:23:28.633Z,1745342608.633 [Reporter](INFO): platform_buoyancy_position 844.316895 cc
2025-04-22T17:23:28.000Z,1745342609.000 [Reporter](INFO): platform_buoyancy_position 848.883057 cc
2025-04-22T17:23:29.436Z,1745342609.436 [Reporter](INFO): platform_buoyancy_position 855.060913 cc
2025-04-22T17:23:29.860Z,1745342609.860 [Reporter](INFO): platform_buoyancy_position 861.372925 cc
2025-04-22T17:23:30.288Z,1745342610.288 [Reporter](INFO): platform_buoyancy_position 865.670532 cc
2025-04-22T17:23:30.804Z,1745342610.804 [Reporter](INFO): platform_buoyancy_position 872.385620 cc
2025-04-22T17:23:31.015Z,1745342611.015 [Reporter](INFO): platform_buoyancy_position 876.548828 cc
2025-04-22T17:23:31.392Z,1745342611.392 [Reporter](INFO): platform_buoyancy_position 880.846436 cc
2025-04-22T17:23:31.916Z,1745342611.916 [Reporter](INFO): platform_buoyancy_position 887.158569 cc
2025-04-22T17:23:32.166Z,1745342612.166 [Reporter](INFO): platform_buoyancy_position 891.590454 cc
2025-04-22T17:23:32.748Z,1745342612.748 [Reporter](INFO): platform_buoyancy_position 898.036865 cc
2025-04-22T17:23:33.061Z,1745342613.061 [Reporter](INFO): platform_buoyancy_position 902.200195 cc
2025-04-22T17:23:33.406Z,1745342613.406 [Reporter](INFO): platform_buoyancy_position 906.766357 cc
2025-04-22T17:23:33.903Z,1745342613.903 [Reporter](INFO): platform_buoyancy_position 913.078491 cc
2025-04-22T17:23:34.348Z,1745342614.348 [Reporter](INFO): platform_buoyancy_position 919.524902 cc
2025-04-22T17:23:34.627Z,1745342614.627 [Reporter](INFO): platform_buoyancy_position 923.688232 cc
2025-04-22T17:23:35.239Z,1745342615.239 [Reporter](INFO): platform_buoyancy_position 932.283325 cc
2025-04-22T17:23:35.495Z,1745342615.495 [Reporter](INFO): platform_buoyancy_position 934.566528 cc
2025-04-22T17:23:35.923Z,1745342615.923 [Reporter](INFO): platform_buoyancy_position 938.998413 cc
2025-04-22T17:23:36.376Z,1745342616.376 [Reporter](INFO): platform_buoyancy_position 946.519165 cc
2025-04-22T17:23:36.819Z,1745342616.819 [Reporter](INFO): platform_buoyancy_position 951.622559 cc
2025-04-22T17:23:37.133Z,1745342617.133 [Reporter](INFO): platform_buoyancy_position 955.920166 cc
2025-04-22T17:23:37.568Z,1745342617.568 [Reporter](INFO): platform_buoyancy_position 962.500854 cc
2025-04-22T17:23:37.988Z,1745342617.988 [Reporter](INFO): platform_buoyancy_position 966.798462 cc
2025-04-22T17:23:38.351Z,1745342618.351 [Reporter](INFO): platform_buoyancy_position 971.096069 cc
2025-04-22T17:23:38.748Z,1745342618.748 [Reporter](INFO): platform_buoyancy_position 977.408264 cc
2025-04-22T17:23:39.143Z,1745342619.143 [Reporter](INFO): platform_buoyancy_position 981.840088 cc
2025-04-22T17:23:39.653Z,1745342619.653 [Reporter](INFO): platform_buoyancy_position 986.137634 cc
2025-04-22T17:23:48.685Z,1745342628.685 [DataOverHttps](IMPORTANT): SBD MTMSN=20250422T172348
2025-04-22T17:23:48.710Z,1745342628.710 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.025817
2025-04-22T17:23:58.813Z,1745342638.813 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20250422T163301/Courier0012.lzma
2025-04-22T17:23:58.816Z,1745342638.816 [DataOverHttps](INFO): Received command: stop
2025-04-22T17:23:58.822Z,1745342638.822 [CommandExec](IMPORTANT): got command stop
2025-04-22T17:23:58.822Z,1745342638.822 [CommandExec](IMPORTANT): Scheduling is paused
2025-04-22T17:23:58.822Z,1745342638.822 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2025-04-22T17:23:59.197Z,1745342639.197 [MissionManager](INFO): MissionManager is completed.
2025-04-22T17:23:59.198Z,1745342639.198 [MissionManager](INFO): Uninitializing Mission sink
2025-04-22T17:23:59.198Z,1745342639.198 [sink] Stopped
2025-04-22T17:23:59.198Z,1745342639.198 [sink](DEBUG): Aggregate::uninitialize sink
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science] Stopped
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science](DEBUG): Aggregate::uninitialize sink:Science
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science:B] Stopped
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science:C] Stopped
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science:E] Stopped
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science:OceanCurrent] Stopped
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sink:Science:OceanCurrent
2025-04-22T17:23:59.198Z,1745342639.198 [sink:Science:OceanCurrent:A.] Stopped
2025-04-22T17:23:59.198Z,1745342639.198 [sink:NeedComms] Stopped
2025-04-22T17:23:59.199Z,1745342639.199 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms
2025-04-22T17:23:59.199Z,1745342639.199 [sink:NeedComms:B.GoToSurface] Stopped
2025-04-22T17:23:59.199Z,1745342639.199 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2025-04-22T17:23:59.199Z,1745342639.199 [sink:NeedComms:D] Stopped
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes] Stopped
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes](DEBUG): Aggregate::uninitialize sink:StandardEnvelopes
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes:B.DepthEnvelope] Stopped
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2025-04-22T17:23:59.199Z,1745342639.199 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2025-04-22T17:23:59.199Z,1745342639.199 [sink:BackseatDriver] Stopped
2025-04-22T17:23:59.200Z,1745342639.200 [sink:BackseatDriver](DEBUG): Aggregate::uninitialize sink:BackseatDriver
2025-04-22T17:23:59.200Z,1745342639.200 [sink:BackseatDriver:A.BackseatDriver] Stopped
2025-04-22T17:23:59.200Z,1745342639.200 [sink:PowerOnly] Stopped
2025-04-22T17:23:59.200Z,1745342639.200 [sink:PowerOnly](DEBUG): Aggregate::uninitialize sink:PowerOnly
2025-04-22T17:23:59.200Z,1745342639.200 [sink:PowerOnly:E.Wait] Stopped
2025-04-22T17:23:59.200Z,1745342639.200 [sink:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component.
2025-04-22T17:23:59.200Z,1745342639.200 [sink:EndingMission] Stopped
2025-04-22T17:23:59.200Z,1745342639.200 [sink:EndingMission](DEBUG): Aggregate::uninitialize sink:EndingMission
2025-04-22T17:23:59.622Z,1745342639.622 [MissionManager](IMPORTANT): Started mission Default
2025-04-22T17:23:59.622Z,1745342639.622 [Default] Running Loop=1
2025-04-22T17:23:59.622Z,1745342639.622 [Default](DEBUG): Aggregate::initialize Default
2025-04-22T17:23:59.623Z,1745342639.623 [Default:B.GoToSurface] Running Loop=1
2025-04-22T17:23:59.623Z,1745342639.623 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2025-04-22T17:23:59.623Z,1745342639.623 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2025-04-22T17:23:59.623Z,1745342639.623 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2025-04-22T17:23:59.623Z,1745342639.623 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2025-04-22T17:23:59.624Z,1745342639.624 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2025-04-22T17:23:59.624Z,1745342639.624 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2025-04-22T17:23:59.629Z,1745342639.629 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2025-04-22T17:23:59.629Z,1745342639.629 [Default:A.Wait] Running Loop=1
2025-04-22T17:23:59.629Z,1745342639.629 [Default:A.Wait](DEBUG): Initialize Wait Component.
2025-04-22T17:23:59.785Z,1745342639.785 [WetLabsBB2FL](INFO): Powering down
2025-04-22T17:23:59.815Z,1745342639.815 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Courier0012.lzma.bak
2025-04-22T17:23:59.815Z,1745342639.815 [DataOverHttps](INFO): SBD MOMSN=24710598
2025-04-22T17:24:00.193Z,1745342640.193 [WetLabsBB2FL](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2025-04-22T17:24:00.193Z,1745342640.193 [WetLabsBB2FL] Hardware Fault, FailCount= 1
2025-04-22T17:24:00.193Z,1745342640.193 [WetLabsBB2FL](ERROR): Hardware Fault
2025-04-22T17:24:00.398Z,1745342640.398 [CBIT](ERROR): Hardware Fault in component: WetLabsBB2FL
2025-04-22T17:24:00.789Z,1745342640.789 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2025-04-22T17:24:00.789Z,1745342640.789 [WetLabsBB2FL] No Fault, FailCount= 1
2025-04-22T17:24:01.002Z,1745342641.002 [WetLabsBB2FL](INFO): Powering up
2025-04-22T17:24:03.618Z,1745342643.618 [WetLabsBB2FL](INFO): Powering down
2025-04-22T17:24:12.931Z,1745342652.931 [Default:A.Wait](INFO): Done Waiting.
2025-04-22T17:24:12.932Z,1745342652.932 [Default:A.Wait] Stopped
2025-04-22T17:24:12.932Z,1745342652.932 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2025-04-22T17:24:13.334Z,1745342653.334 [Default:CheckIn] Running Loop=1
2025-04-22T17:24:13.334Z,1745342653.334 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-22T17:24:13.335Z,1745342653.335 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-22T17:24:15.297Z,1745342655.297 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,172414.00,A,3648.16762,N,12147.28311,W,0.078,0.00,220425,,,A*70
2025-04-22T17:24:15.299Z,1745342655.299 [NAL9602](INFO): GPS fix at 20250422T172414: (36.802794, -121.788052)
2025-04-22T17:24:15.352Z,1745342655.352 [Default:CheckIn:Read_GPS] Stopped
2025-04-22T17:24:15.352Z,1745342655.352 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-22T17:24:23.956Z,1745342663.956 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250422T163301/Courier0015.lzma
2025-04-22T17:24:24.959Z,1745342664.959 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Courier0015.lzma.bak
2025-04-22T17:24:24.959Z,1745342664.959 [DataOverHttps](INFO): SBD MOMSN=24710602
2025-04-22T17:24:45.243Z,1745342685.243 [DataOverHttps](INFO): Sending 1428 bytes from file Logs/20250422T163301/Express0013.lzma
2025-04-22T17:24:46.235Z,1745342686.235 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0013.lzma.bak
2025-04-22T17:24:46.235Z,1745342686.235 [DataOverHttps](INFO): SBD MOMSN=24710605
2025-04-22T17:25:08.181Z,1745342708.181 [DataOverHttps](INFO): Sending 335 bytes from file Logs/20250422T163301/Express0016.lzma
2025-04-22T17:25:09.184Z,1745342709.184 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0016.lzma.bak
2025-04-22T17:25:09.184Z,1745342709.184 [DataOverHttps](INFO): SBD MOMSN=24710652
2025-04-22T17:25:28.220Z,1745342728.220 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20250422T163301/Express0019.lzma
2025-04-22T17:25:29.219Z,1745342729.219 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0019.lzma.bak
2025-04-22T17:25:29.219Z,1745342729.219 [DataOverHttps](INFO): SBD MOMSN=24710659
2025-04-22T17:25:30.468Z,1745342730.468 [Default:CheckIn:Read_Iridium] Stopped
2025-04-22T17:25:30.469Z,1745342730.469 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-22T17:25:30.469Z,1745342730.469 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-22T17:25:41.881Z,1745342741.881 [CommandExec](IMPORTANT): got command failComponent
2025-04-22T17:25:41.882Z,1745342741.882 [CommandExec](IMPORTANT): Failed components:
2025-04-22T17:25:41.882Z,1745342741.882 [CommandExec](IMPORTANT): No failed Components.
2025-04-22T17:25:44.379Z,1745342744.379 [CommandExec](IMPORTANT): got command gfscan
2025-04-22T17:25:44.478Z,1745342744.478 [GFScanner](IMPORTANT): Beginning ground fault scan
2025-04-22T17:25:48.915Z,1745342748.915 [GFScanner](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006156
CHAN A1 (24V): -0.004287
CHAN A2 (12V): -0.005157
CHAN A3 (5V): -0.003967
CHAN B0 (3.3V): -0.001632
CHAN B1 (3.15aV): -0.000657
CHAN B2 (3.15bV): -0.001156
CHAN B3 (GND): -0.001101
OPEN: 0.005614
Full Scale: +/- 1 mA
2025-04-22T17:26:03.122Z,1745342763.122 [CommandExec](IMPORTANT): got command schedule
2025-04-22T17:26:03.122Z,1745342763.122 [CommandExec](FAULT): Scheduling was paused by a command at 2025-04-22T17:23:58Z
2025-04-22T17:26:07.019Z,1745342767.019 [NAL9602](INFO): SBD MO Status=2, MOMSN=8274, MT Status=2, MTMSN=0
2025-04-22T17:26:07.020Z,1745342767.020 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-04-22T17:26:11.267Z,1745342771.267 [CommandExec](IMPORTANT): got command schedule clear
2025-04-22T17:26:11.267Z,1745342771.267 [CommandExec](IMPORTANT): Cleared 0 scheduled commands.
2025-04-22T17:26:11.268Z,1745342771.268 [CommandExec](IMPORTANT): got command schedule resume
2025-04-22T17:26:11.268Z,1745342771.268 [CommandExec](IMPORTANT): Scheduling is resumed
2025-04-22T17:26:27.619Z,1745342787.619 [NAL9602](INFO): SBD MO Status=2, MOMSN=8274, MT Status=2, MTMSN=0
2025-04-22T17:26:27.619Z,1745342787.619 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-04-22T17:26:56.302Z,1745342816.302 [NAL9602](INFO): SBD MO Status=2, MOMSN=8274, MT Status=2, MTMSN=0
2025-04-22T17:26:56.302Z,1745342816.302 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-04-22T17:28:23.987Z,1745342903.987 [NAL9602](INFO): SBD MO Status=2, MOMSN=8274, MT Status=2, MTMSN=0
2025-04-22T17:28:23.988Z,1745342903.988 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2025-04-22T17:29:17.228Z,1745342957.228 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2025-04-22T17:29:47.919Z,1745342987.919 [NAL9602](INFO): Not Powering down - fast GPS
2025-04-22T17:30:30.790Z,1745343030.790 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2025-04-22T17:30:30.790Z,1745343030.790 [Default:CheckIn:C.Wait] Stopped
2025-04-22T17:30:30.791Z,1745343030.791 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2025-04-22T17:30:30.791Z,1745343030.791 [Default:CheckIn:D] Running Loop=1
2025-04-22T17:30:31.193Z,1745343031.193 [Default:CheckIn:D] Stopped
2025-04-22T17:30:31.194Z,1745343031.194 [Default:CheckIn:E] Running Loop=1
2025-04-22T17:30:31.615Z,1745343031.615 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.526184 min
2025-04-22T17:30:31.615Z,1745343031.615 [Default:CheckIn:E] Stopped
2025-04-22T17:30:31.615Z,1745343031.615 [Default:CheckIn](INFO): Completed Default:CheckIn
2025-04-22T17:30:31.615Z,1745343031.615 [Default:CheckIn] Stopped
2025-04-22T17:30:31.615Z,1745343031.615 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2025-04-22T17:30:31.616Z,1745343031.616 [Default:CheckIn](INFO): Running loop #2
2025-04-22T17:30:31.616Z,1745343031.616 [Default:CheckIn] Running Loop=2
2025-04-22T17:30:31.616Z,1745343031.616 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2025-04-22T17:30:31.616Z,1745343031.616 [Default:CheckIn:Read_GPS] Running Loop=1
2025-04-22T17:30:33.603Z,1745343033.603 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173032.00,A,3648.16963,N,12147.28012,W,0.019,0.00,220425,,,A*79
2025-04-22T17:30:33.624Z,1745343033.624 [NAL9602](INFO): GPS fix at 20250422T173032: (36.802827, -121.788002)
2025-04-22T17:30:33.654Z,1745343033.654 [Default:CheckIn:Read_GPS] Stopped
2025-04-22T17:30:33.655Z,1745343033.655 [Default:CheckIn:Read_Iridium] Running Loop=1
2025-04-22T17:30:42.864Z,1745343042.864 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20250422T163301/Courier0021.lzma
2025-04-22T17:30:43.864Z,1745343043.864 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Courier0021.lzma.bak
2025-04-22T17:30:43.865Z,1745343043.865 [DataOverHttps](INFO): SBD MOMSN=24710676
2025-04-22T17:30:50.389Z,1745343050.389 [Waterlinked](ERROR): only read 0 of 1 data item for BIT error. Device response::TS,24052713140498, 0.0 0.0,1475.0, 0
2025-04-22T17:31:03.546Z,1745343063.546 [DataOverHttps](INFO): Sending 597 bytes from file Logs/20250422T163301/Express0022.lzma
2025-04-22T17:31:04.135Z,1745343064.135 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2025-04-22T17:31:04.217Z,1745343064.217 [NAL9602](ERROR): received:
+CSQ:0
OK74, 2, 0, 0, 0
OK
2025-04-22T17:31:04.547Z,1745343064.547 [DataOverHttps](INFO): Moved sent file to Logs/20250422T163301/Express0022.lzma.bak
2025-04-22T17:31:04.547Z,1745343064.547 [DataOverHttps](INFO): SBD MOMSN=24710686
2025-04-22T17:31:05.859Z,1745343065.859 [Default:CheckIn:Read_Iridium] Stopped
2025-04-22T17:31:05.859Z,1745343065.859 [Default:CheckIn:C.Wait] Running Loop=1
2025-04-22T17:31:05.859Z,1745343065.859 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2025-04-22T17:31:07.983Z,1745343067.983 [CommandExec](IMPORTANT): got command schedule resume