2024-08-07T22:58:01.127Z,1723071481.127 [CommandExec](IMPORTANT): got command restart logs 2024-08-07T22:58:01.906Z,1723071481.906 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:58:18.874Z,1723071498.874 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:58:19.311Z,1723071499.311 [CommandExec](IMPORTANT): got command report mod Dock.dock_voltage_present 2024-08-07T22:58:19.348Z,1723071499.348 [CommandExec](IMPORTANT): got command docking arm 2024-08-07T22:58:19.348Z,1723071499.348 [CommandExec](IMPORTANT): Switching docking module to ARM. 2024-08-07T22:58:19.399Z,1723071499.399 [Reporter](INFO): Dock.dock_voltage_present 0 bool 2024-08-07T22:58:19.771Z,1723071499.771 [DockingStepper](INFO): Resume 2024-08-07T22:58:20.176Z,1723071500.176 [DockingStepper](INFO): Resuming 2024-08-07T22:58:20.195Z,1723071500.195 [Reporter](INFO): Dock.dock_voltage_present 0 bool 2024-08-07T22:58:20.587Z,1723071500.587 [DockingStepper](INFO): Start 2024-08-07T22:58:20.587Z,1723071500.587 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-08-07T22:58:20.707Z,1723071500.707 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-08-07T22:58:21.002Z,1723071501.002 [DockingStepper](INFO): Starting 2024-08-07T22:58:21.425Z,1723071501.425 [DockingStepper](INFO): Starting 2024-08-07T22:58:21.807Z,1723071501.807 [DockingStepper](INFO): Starting 2024-08-07T22:58:21.861Z,1723071501.861 [DockingStepper](INFO): Init string: /1z16368aE13561N3m50 2024-08-07T22:58:22.210Z,1723071502.210 [DockingStepper](INFO): Starting 2024-08-07T22:58:22.642Z,1723071502.642 [DockingStepper](INFO): Starting 2024-08-07T22:58:23.004Z,1723071503.004 [DockingStepper](INFO): Starting 2024-08-07T22:58:23.464Z,1723071503.464 [DockingStepper](INFO): Starting 2024-08-07T22:58:23.494Z,1723071503.494 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-08-07T22:58:23.831Z,1723071503.831 [DockingStepper](INFO): Starting 2024-08-07T22:58:23.840Z,1723071503.840 [Reporter](INFO): Dock.dock_voltage_present 0 bool 2024-08-07T22:58:24.231Z,1723071504.231 [DockingStepper](INFO): Changing to mode: 2 2024-08-07T22:58:24.232Z,1723071504.232 [DockingStepper](INFO): Armed mode. 2024-08-07T22:58:24.294Z,1723071504.294 [DockingStepper](INFO): Commanding negative:54599 2024-08-07T22:58:28.474Z,1723071508.474 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:58:37.694Z,1723071517.694 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:58:47.047Z,1723071527.047 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:58:56.162Z,1723071536.162 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:59:05.579Z,1723071545.579 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:59:14.718Z,1723071554.718 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:59:24.038Z,1723071564.038 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:59:33.198Z,1723071573.198 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:59:36.623Z,1723071576.623 [CommandExec](IMPORTANT): got command docking slide 2024-08-07T22:59:36.623Z,1723071576.623 [CommandExec](IMPORTANT): Switching docking module to SLIDE. 2024-08-07T22:59:36.686Z,1723071576.686 [DockingStepper](INFO): Changing to mode: 4 2024-08-07T22:59:36.686Z,1723071576.686 [DockingStepper](INFO): Slide mode. 2024-08-07T22:59:36.750Z,1723071576.750 [DockingStepper](INFO): Commanding positive:18273 2024-08-07T22:59:42.690Z,1723071582.690 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:59:51.315Z,1723071591.315 [CommandExec](IMPORTANT): got command schedule list 2024-08-07T22:59:51.954Z,1723071591.954 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T22:59:54.240Z,1723071594.240 [CommandExec](IMPORTANT): got command schedule pause 2024-08-07T22:59:54.240Z,1723071594.240 [CommandExec](IMPORTANT): Scheduling is paused 2024-08-07T23:00:01.194Z,1723071601.194 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:00:10.530Z,1723071610.530 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:00:23.051Z,1723071623.051 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:00:33.838Z,1723071633.838 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:00:35.320Z,1723071635.320 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-08-07T23:00:35.320Z,1723071635.320 [Default:CheckIn:C.Wait] Stopped 2024-08-07T23:00:35.320Z,1723071635.320 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-08-07T23:00:35.320Z,1723071635.320 [Default:CheckIn:D] Running Loop=1 2024-08-07T23:00:35.796Z,1723071635.796 [Default:CheckIn:D] Stopped 2024-08-07T23:00:35.796Z,1723071635.796 [Default:CheckIn:E] Running Loop=1 2024-08-07T23:00:36.173Z,1723071636.173 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.967259 min 2024-08-07T23:00:36.173Z,1723071636.173 [Default:CheckIn:E] Stopped 2024-08-07T23:00:36.173Z,1723071636.173 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-08-07T23:00:36.173Z,1723071636.173 [Default:CheckIn] Stopped 2024-08-07T23:00:36.173Z,1723071636.173 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-07T23:00:36.174Z,1723071636.174 [Default:CheckIn](INFO): Running loop #3 2024-08-07T23:00:36.174Z,1723071636.174 [Default:CheckIn] Running Loop=3 2024-08-07T23:00:36.174Z,1723071636.174 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-07T23:00:36.174Z,1723071636.174 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-07T23:00:38.189Z,1723071638.189 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230037.00,A,3648.15975,N,12147.28208,W,0.525,46.31,070824,,,D*40 2024-08-07T23:00:38.200Z,1723071638.200 [NAL9602](INFO): GPS fix at 20240807T230037: (36.802662, -121.788035) 2024-08-07T23:00:38.239Z,1723071638.239 [Default:CheckIn:Read_GPS] Stopped 2024-08-07T23:00:38.239Z,1723071638.239 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-08-07T23:00:41.485Z,1723071641.485 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240807T223549/Courier0007.lzma 2024-08-07T23:00:42.483Z,1723071642.483 [DataOverHttps](INFO): Moved sent file to Logs/20240807T223549/Courier0007.lzma.bak 2024-08-07T23:00:42.484Z,1723071642.484 [DataOverHttps](INFO): SBD MOMSN=21448260 2024-08-07T23:00:51.692Z,1723071651.692 [DataOverHttps](IMPORTANT): SBD MTMSN=20240807T230050 2024-08-07T23:01:00.150Z,1723071660.150 [DataOverHttps](INFO): Sending 269 bytes from file Logs/20240807T225801/Courier0000.lzma 2024-08-07T23:01:00.153Z,1723071660.153 [DataOverHttps](INFO): Received command: sched "load Engineering/sink.tl;set sink.MissionTimeout 7 min;set sink.Depth 0.75 m;set sink.DepthDeadband .5 m;set sink.DoBallastAndTrim 0 bool;set sink.MinAltitude .0001 m;set sink.MaxDepth 5 m;set sink.MinOffshore .00001 km" 27jx8 1 2 2024-08-07T23:01:00.227Z,1723071660.227 [CommandExec](IMPORTANT): got command schedule "load Engineering/sink.tl;set sink.MissionTimeout 7 min;set sink.Depth 0.75 m;set sink.DepthDeadband .5 m;set sink.DoBallastAndTrim 0 bool;set sink.MinAltitude .0001 m;set sink.MaxDepth 5 m;set sink.MinOffshore .00001 km" 27jx8 1 2.000000 2024-08-07T23:01:00.227Z,1723071660.227 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=27jx8 2024-08-07T23:01:00.228Z,1723071660.228 [CommandExec](IMPORTANT): Scheduled #1 (#1 of 2 with id='27jx8'): "load Engineering/sink.tl;set sink.MissionTimeout 7 min;set sink.Depth 0.75 m;set sink.DepthDeadband .5 m;set sink.DoBallastAndTrim 0 bool;set sink.MinAltitude .0001 m;set sink.MaxDepth 5 m;set sink.MinOffshore .00001 km", AFTER MISSION 2024-08-07T23:01:00.228Z,1723071660.228 [CommandExec](FAULT): Scheduling was paused by a command at 2024-08-07T22:59:54Z 2024-08-07T23:01:01.354Z,1723071661.354 [DataOverHttps](INFO): Moved sent file to Logs/20240807T225801/Courier0000.lzma.bak 2024-08-07T23:01:01.355Z,1723071661.355 [DataOverHttps](IMPORTANT): SBD MOMSN=21448263, MTMSN=20240807T230100 2024-08-07T23:01:09.338Z,1723071669.338 [DataOverHttps](INFO): Received command: sched "set sink:NeedComms.GPSTimeout 10 s;set sink:NeedComms.CommsTimeout 10 s;run" 27jx8 2 2 2024-08-07T23:01:09.364Z,1723071669.364 [CommandExec](IMPORTANT): got command schedule "set sink:NeedComms.GPSTimeout 10 s;set sink:NeedComms.CommsTimeout 10 s;run" 27jx8 2 2.000000 2024-08-07T23:01:09.364Z,1723071669.364 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=27jx8 2024-08-07T23:01:09.365Z,1723071669.365 [CommandExec](IMPORTANT): Scheduled #2 (#2 of 2 with id='27jx8'): "set sink:NeedComms.GPSTimeout 10 s;set sink:NeedComms.CommsTimeout 10 s;run", AFTER MISSION 2024-08-07T23:01:09.366Z,1723071669.366 [CommandExec](FAULT): Scheduling was paused by a command at 2024-08-07T22:59:54Z 2024-08-07T23:01:10.614Z,1723071670.614 [DataOverHttps](IMPORTANT): SBD MTMSN=20240807T230109 2024-08-07T23:01:11.603Z,1723071671.603 [NAL9602](INFO): SBD MO Status=2, MOMSN=40381, MT Status=2, MTMSN=0 2024-08-07T23:01:11.603Z,1723071671.603 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-08-07T23:01:18.535Z,1723071678.535 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240807T225801/Courier0003.lzma 2024-08-07T23:01:18.537Z,1723071678.537 [DataOverHttps](INFO): Received command: sched "load Engineering/OnDock.tl;set OnDock.DockedTime 15 min;set OnDock.DetachedTimeout 100 min;set OnDock.RangeTimeout 100 min;set OnDock.TrackingUpdatePeriod 100 min;set OnDock.MinAltitude 0.0001 m;set OnDock.MinOffshore 0.0001 km" 27jxq 1 2 2024-08-07T23:01:18.577Z,1723071678.577 [CommandExec](IMPORTANT): got command schedule "load Engineering/OnDock.tl;set OnDock.DockedTime 15 min;set OnDock.DetachedTimeout 100 min;set OnDock.RangeTimeout 100 min;set OnDock.TrackingUpdatePeriod 100 min;set OnDock.MinAltitude 0.0001 m;set OnDock.MinOffshore 0.0001 km" 27jxq 1 2.000000 2024-08-07T23:01:18.597Z,1723071678.597 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=27jxq 2024-08-07T23:01:18.598Z,1723071678.598 [CommandExec](IMPORTANT): Scheduled #3 (#1 of 2 with id='27jxq'): "load Engineering/OnDock.tl;set OnDock.DockedTime 15 min;set OnDock.DetachedTimeout 100 min;set OnDock.RangeTimeout 100 min;set OnDock.TrackingUpdatePeriod 100 min;set OnDock.MinAltitude 0.0001 m;set OnDock.MinOffshore 0.0001 km", AFTER MISSION 2024-08-07T23:01:18.598Z,1723071678.598 [CommandExec](FAULT): Scheduling was paused by a command at 2024-08-07T22:59:54Z 2024-08-07T23:01:19.729Z,1723071679.729 [DataOverHttps](INFO): Moved sent file to Logs/20240807T225801/Courier0003.lzma.bak 2024-08-07T23:01:19.730Z,1723071679.730 [DataOverHttps](IMPORTANT): SBD MOMSN=21448271, MTMSN=20240807T230118 2024-08-07T23:01:22.268Z,1723071682.268 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, +0.70, -0.00, , 10.04, 0.00 2024-08-07T23:01:27.227Z,1723071687.227 [CommandExec](IMPORTANT): got command schedule resume 2024-08-07T23:01:27.227Z,1723071687.227 [CommandExec](IMPORTANT): Scheduling is resumed 2024-08-07T23:01:27.348Z,1723071687.348 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/sink.tl 2024-08-07T23:01:27.348Z,1723071687.348 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/sink.tl 2024-08-07T23:01:27.348Z,1723071687.348 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/sink.tl 2024-08-07T23:01:27.351Z,1723071687.351 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/sink.tl 2024-08-07T23:01:27.910Z,1723071687.910 [DataOverHttps](INFO): Received command: sched "set OnDock.IfconfigInterval 3 min;run" 27jxq 2 2 2024-08-07T23:01:31.242Z,1723071691.242 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/sink.tl translated into: 2 20 1 2.5 20 20 10 45 10 0.5 25 98 5 30 2 2024-08-07T23:01:31.252Z,1723071691.252 [MissionManager](INFO): DefineArg sink.MissionTimeout = 2.000000 h 2024-08-07T23:01:31.263Z,1723071691.263 [MissionManager](INFO): DefineArg sink.Depth = 20.000000 m 2024-08-07T23:01:31.266Z,1723071691.266 [MissionManager](INFO): DefineArg sink.DepthDeadband = 1.000000 m 2024-08-07T23:01:31.269Z,1723071691.269 [MissionManager](INFO): DefineArg sink.SurfaceThreshold = 2.500000 m 2024-08-07T23:01:31.272Z,1723071691.272 [MissionManager](INFO): DefineArg sink.WaitToFloat = 20.000000 min 2024-08-07T23:01:31.292Z,1723071691.292 [MissionManager](INFO): DefineArg sink.TargetDepthTimeout = 20.000000 min 2024-08-07T23:01:31.297Z,1723071691.297 [MissionManager](INFO): DefineArg sink.DoBallastAndTrim = 1 bool 2024-08-07T23:01:31.309Z,1723071691.309 [MissionManager](INFO): DefineArg sink.BTSettleTime = 10.000000 min 2024-08-07T23:01:31.316Z,1723071691.316 [MissionManager](INFO): DefineArg sink.EstimationTimeout = 45.000000 min 2024-08-07T23:01:31.330Z,1723071691.330 [MissionManager](INFO): DefineArg sink.MinEstimationTime = 10.000000 min 2024-08-07T23:01:31.338Z,1723071691.338 [MissionManager](INFO): DefineArg sink.MassEstimationErrorBound = 0.500000 mm 2024-08-07T23:01:31.346Z,1723071691.346 [MissionManager](INFO): DefineArg sink.BuoyEstimationErrorBound = 25.000000 cc 2024-08-07T23:01:31.370Z,1723071691.370 [MissionManager](INFO): DefineArg sink.EstimationConfidence = 98.000000 % 2024-08-07T23:01:31.373Z,1723071691.373 [MissionManager](INFO): DefineArg sink.MinAltitude = 5.000000 m 2024-08-07T23:01:31.381Z,1723071691.381 [MissionManager](INFO): DefineArg sink.MaxDepth = 30.000000 m 2024-08-07T23:01:31.395Z,1723071691.395 [MissionManager](INFO): DefineArg sink.MinOffshore = 2.000000 km 2024-08-07T23:01:31.396Z,1723071691.396 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.tl 2024-08-07T23:01:31.396Z,1723071691.396 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/Science.tl 2024-08-07T23:01:31.398Z,1723071691.398 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/Science.tl 2024-08-07T23:01:35.033Z,1723071695.033 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/Science.tl translated into: NaN 3 100 80 20 5 NaN NaN 2.0 NaN NaN 5 NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN NaN Triggered. PeakChl values on consecutive yo-yo profiles fall in [ ] (NaN bound is ignored). 2024-08-07T23:01:35.092Z,1723071695.092 [MissionManager](INFO): DefineArg sink:Science.PeakDetectChlActive = 0 bool 2024-08-07T23:01:35.103Z,1723071695.103 [MissionManager](INFO): DefineArg sink:Science.TimeWindowPeakReport = nan min 2024-08-07T23:01:35.105Z,1723071695.105 [MissionManager](INFO): DefineArg sink:Science.HighestChlPeakReportActive = 0 bool 2024-08-07T23:01:35.116Z,1723071695.116 [MissionManager](INFO): DefineArg sink:Science.HighestSaltPeakReportActive = 0 bool 2024-08-07T23:01:35.132Z,1723071695.132 [MissionManager](INFO): DefineArg sink:Science.HighestOilPeakReportActive = 0 bool 2024-08-07T23:01:35.192Z,1723071695.192 [MissionManager](INFO): DefineArg sink:Science.PatchTracking = 0 bool 2024-08-07T23:01:35.224Z,1723071695.224 [MissionManager](INFO): DefineArg sink:Science.FilterWidthHorizontal = 3.000000 count 2024-08-07T23:01:35.275Z,1723071695.275 [MissionManager](INFO): DefineArg sink:Science.NumProfilesSlidingwindow = 100.000000 count 2024-08-07T23:01:35.304Z,1723071695.304 [MissionManager](INFO): DefineArg sink:Science.OffPeakFractionHorizontal = 80.000000 % 2024-08-07T23:01:35.320Z,1723071695.320 [MissionManager](INFO): DefineArg sink:Science.PeakDetectNO3Active = 0 bool 2024-08-07T23:01:35.359Z,1723071695.359 [MissionManager](INFO): DefineArg sink:Science.PeakDetectOilActive = 0 bool 2024-08-07T23:01:35.378Z,1723071695.378 [MissionManager](INFO): DefineArg sink:Science.PeakDetectFDOMActive = 0 bool 2024-08-07T23:01:35.381Z,1723071695.381 [MissionManager](INFO): DefineArg sink:Science.PeakDetectSalinityActive = 0 bool 2024-08-07T23:01:35.471Z,1723071695.471 [MissionManager](INFO): DefineArg sink:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2024-08-07T23:01:35.514Z,1723071695.514 [MissionManager](INFO): DefineArg sink:Science.EnabledAanderaaO2 = 0 bool 2024-08-07T23:01:35.530Z,1723071695.530 [MissionManager](INFO): DefineArg sink:Science.EnabledNeilBrown = 0 bool 2024-08-07T23:01:35.533Z,1723071695.533 [MissionManager](INFO): DefineArg sink:Science.EnabledSeabird = 1 bool 2024-08-07T23:01:35.551Z,1723071695.551 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsBB2FL = 1 bool 2024-08-07T23:01:35.579Z,1723071695.579 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2024-08-07T23:01:35.588Z,1723071695.588 [MissionManager](INFO): DefineArg sink:Science.EnabledWetLabsUBAT = 1 bool 2024-08-07T23:01:35.608Z,1723071695.608 [MissionManager](INFO): DefineArg sink:Science.LowPassWindowLength = 20.000000 count 2024-08-07T23:01:35.615Z,1723071695.615 [MissionManager](INFO): DefineArg sink:Science.MedianFilterLen = 5.000000 count 2024-08-07T23:01:35.623Z,1723071695.623 [MissionManager](INFO): DefineArg sink:Science.PeakShallowBound = nan m 2024-08-07T23:01:35.659Z,1723071695.659 [MissionManager](INFO): DefineArg sink:Science.PeakDeepBound = nan m 2024-08-07T23:01:35.683Z,1723071695.683 [MissionManager](INFO): DefineArg sink:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2024-08-07T23:01:35.685Z,1723071695.685 [MissionManager](INFO): DefineArg sink:Science.ChlThreshTriggerActive = 0 bool 2024-08-07T23:01:35.708Z,1723071695.708 [MissionManager](INFO): DefineArg sink:Science.ChlLowerThresh = nan ug/l 2024-08-07T23:01:35.720Z,1723071695.720 [MissionManager](INFO): DefineArg sink:Science.ChlUpperThresh = nan ug/l 2024-08-07T23:01:35.747Z,1723071695.747 [MissionManager](INFO): DefineArg sink:Science.NumProfilesThresh = 5.000000 count 2024-08-07T23:01:35.758Z,1723071695.758 [MissionManager](INFO): DefineOutput sink:Science.PeakChl = nan ug/l 2024-08-07T23:01:35.761Z,1723071695.761 [MissionManager](INFO): DefineOutput sink:Science.PeakChlDepth = nan m 2024-08-07T23:01:35.791Z,1723071695.791 [MissionManager](INFO): DefineOutput sink:Science.PeakChlTemperature = nan degC 2024-08-07T23:01:35.810Z,1723071695.810 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLatitude = nan arcdeg 2024-08-07T23:01:35.823Z,1723071695.823 [MissionManager](INFO): DefineOutput sink:Science.PeakChlLongitude = nan arcdeg 2024-08-07T23:01:35.844Z,1723071695.844 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3 = nan umol/l 2024-08-07T23:01:35.859Z,1723071695.859 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Depth = nan m 2024-08-07T23:01:35.883Z,1723071695.883 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Latitude = nan arcdeg 2024-08-07T23:01:35.900Z,1723071695.900 [MissionManager](INFO): DefineOutput sink:Science.PeakNO3Longitude = nan arcdeg 2024-08-07T23:01:35.908Z,1723071695.908 [MissionManager](INFO): DefineOutput sink:Science.PeakOil = nan kg/m3 2024-08-07T23:01:35.916Z,1723071695.916 [MissionManager](INFO): DefineOutput sink:Science.PeakOilDepth = nan m 2024-08-07T23:01:35.955Z,1723071695.955 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLatitude = nan arcdeg 2024-08-07T23:01:35.972Z,1723071695.972 [MissionManager](INFO): DefineOutput sink:Science.PeakOilLongitude = nan arcdeg 2024-08-07T23:01:35.984Z,1723071695.984 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOM = nan ppb 2024-08-07T23:01:36.003Z,1723071696.003 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMDepth = nan m 2024-08-07T23:01:36.015Z,1723071696.015 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMTemperature = nan degC 2024-08-07T23:01:36.023Z,1723071696.023 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLatitude = nan arcdeg 2024-08-07T23:01:36.038Z,1723071696.038 [MissionManager](INFO): DefineOutput sink:Science.PeakFDOMLongitude = nan arcdeg 2024-08-07T23:01:36.041Z,1723071696.041 [MissionManager](INFO): DefineOutput sink:Science.PeakSalt = nan psu 2024-08-07T23:01:36.052Z,1723071696.052 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltDepth = nan m 2024-08-07T23:01:36.063Z,1723071696.063 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltTemperature = nan degC 2024-08-07T23:01:36.071Z,1723071696.071 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLatitude = nan arcdeg 2024-08-07T23:01:36.110Z,1723071696.110 [MissionManager](INFO): DefineOutput sink:Science.PeakSaltLongitude = nan arcdeg 2024-08-07T23:01:36.113Z,1723071696.113 [MissionManager](INFO): DefineOutput sink:Science.PatchChl = nan ug/l 2024-08-07T23:01:36.164Z,1723071696.164 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDepth = nan m 2024-08-07T23:01:36.195Z,1723071696.195 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLatitude = nan arcdeg 2024-08-07T23:01:36.213Z,1723071696.213 [MissionManager](INFO): DefineOutput sink:Science.PatchChlLongitude = nan arcdeg 2024-08-07T23:01:36.237Z,1723071696.237 [MissionManager](INFO): DefineOutput sink:Science.PatchChlDistance = nan m 2024-08-07T23:01:36.248Z,1723071696.248 [MissionManager](INFO): DefineOutput sink:Science.PatchSalt = nan psu 2024-08-07T23:01:36.260Z,1723071696.260 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDepth = nan m 2024-08-07T23:01:36.281Z,1723071696.281 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLatitude = nan arcdeg 2024-08-07T23:01:36.285Z,1723071696.285 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltLongitude = nan arcdeg 2024-08-07T23:01:36.297Z,1723071696.297 [MissionManager](INFO): DefineOutput sink:Science.PatchSaltDistance = nan m 2024-08-07T23:01:36.315Z,1723071696.315 [MissionManager](INFO): DefineOutput sink:Science.PatchOil = nan psu 2024-08-07T23:01:36.329Z,1723071696.329 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDepth = nan m 2024-08-07T23:01:36.353Z,1723071696.353 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLatitude = nan arcdeg 2024-08-07T23:01:36.364Z,1723071696.364 [MissionManager](INFO): DefineOutput sink:Science.PatchOilLongitude = nan arcdeg 2024-08-07T23:01:36.372Z,1723071696.372 [MissionManager](INFO): DefineOutput sink:Science.PatchOilDistance = nan m 2024-08-07T23:01:36.384Z,1723071696.384 [MissionManager](INFO): DefineOutput sink:Science.TriggeredOnChl = 0 bool 2024-08-07T23:01:36.415Z,1723071696.415 [MissionManager](INFO): DefineOutput sink:Science.ChlTriggering = nan ug/l 2024-08-07T23:01:36.606Z,1723071696.606 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2024-08-07T23:01:36.686Z,1723071696.686 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2024-08-07T23:01:36.749Z,1723071696.749 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2024-08-07T23:01:36.801Z,1723071696.801 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2024-08-07T23:01:36.866Z,1723071696.866 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2024-08-07T23:01:36.927Z,1723071696.927 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2024-08-07T23:01:36.992Z,1723071696.992 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2024-08-07T23:01:37.050Z,1723071697.050 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2024-08-07T23:01:37.143Z,1723071697.143 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Construct ValueDetect. 2024-08-07T23:01:37.168Z,1723071697.168 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.tl 2024-08-07T23:01:37.168Z,1723071697.168 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/NeedComms.tl 2024-08-07T23:01:37.169Z,1723071697.169 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/NeedComms.tl 2024-08-07T23:01:38.205Z,1723071698.205 [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 2024-08-07T23:01:38.265Z,1723071698.265 [MissionManager](INFO): DefineArg sink:NeedComms.DiveInterval = 1.000000 h 2024-08-07T23:01:38.277Z,1723071698.277 [MissionManager](INFO): DefineArg sink:NeedComms.WaitForPitchUp = 10.000000 min 2024-08-07T23:01:38.296Z,1723071698.296 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacePitch = 20.000000 arcdeg 2024-08-07T23:01:38.303Z,1723071698.303 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceDepthRate = nan m/s 2024-08-07T23:01:38.315Z,1723071698.315 [MissionManager](INFO): DefineArg sink:NeedComms.SurfaceSpeed = 1.000000 m/s 2024-08-07T23:01:38.342Z,1723071698.342 [MissionManager](INFO): DefineArg sink:NeedComms.SurfacingTimeout = 1000.000000 s 2024-08-07T23:01:38.345Z,1723071698.345 [MissionManager](INFO): DefineArg sink:NeedComms.GPSTimeout = 7.000000 min 2024-08-07T23:01:38.352Z,1723071698.352 [MissionManager](INFO): DefineArg sink:NeedComms.CommsTimeout = 30.000000 min 2024-08-07T23:01:38.387Z,1723071698.387 [sink:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-08-07T23:01:38.464Z,1723071698.464 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2024-08-07T23:01:38.464Z,1723071698.464 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2024-08-07T23:01:38.494Z,1723071698.494 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2024-08-07T23:01:38.831Z,1723071698.831 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2024-08-07T23:01:38.848Z,1723071698.848 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinAltitude = 5.000000 m 2024-08-07T23:01:38.857Z,1723071698.857 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2024-08-07T23:01:38.888Z,1723071698.888 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MaxDepth = 200.000000 m 2024-08-07T23:01:38.897Z,1723071698.897 [MissionManager](INFO): DefineArg sink:StandardEnvelopes.MinOffshore = 2000.000000 m 2024-08-07T23:01:38.934Z,1723071698.934 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2024-08-07T23:01:38.970Z,1723071698.970 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2024-08-07T23:01:39.008Z,1723071699.008 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2024-08-07T23:01:39.067Z,1723071699.067 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2024-08-07T23:01:39.068Z,1723071699.068 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2024-08-07T23:01:39.069Z,1723071699.069 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2024-08-07T23:01:39.143Z,1723071699.143 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2024-08-07T23:01:39.151Z,1723071699.151 [MissionManager](INFO): DefineArg sink:BackseatDriver.EnableBackseat = 0 bool 2024-08-07T23:01:39.166Z,1723071699.166 [sink:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2024-08-07T23:01:39.169Z,1723071699.169 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2024-08-07T23:01:39.169Z,1723071699.169 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2024-08-07T23:01:39.179Z,1723071699.179 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2024-08-07T23:01:39.617Z,1723071699.617 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2024-08-07T23:01:39.638Z,1723071699.638 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleAll = 0 bool 2024-08-07T23:01:39.641Z,1723071699.641 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad1 = 0 bool 2024-08-07T23:01:39.648Z,1723071699.648 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad2 = 0 bool 2024-08-07T23:01:39.666Z,1723071699.666 [MissionManager](INFO): DefineArg sink:PowerOnly.SampleLoad3 = 0 bool 2024-08-07T23:01:39.674Z,1723071699.674 [MissionManager](INFO): DefineArg sink:PowerOnly.EnabledPowerOnly = 0 bool 2024-08-07T23:01:39.689Z,1723071699.689 [sink:PowerOnly:E.Wait](DEBUG): Construct Wait. 2024-08-07T23:01:39.700Z,1723071699.700 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BallastAndTrim.tl 2024-08-07T23:01:39.700Z,1723071699.700 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BallastAndTrim.tl 2024-08-07T23:01:39.726Z,1723071699.726 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BallastAndTrim.tl 2024-08-07T23:01:41.424Z,1723071701.424 [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 = 2024-08-07T23:01:41.456Z,1723071701.456 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepth = 25.000000 m 2024-08-07T23:01:41.478Z,1723071701.478 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSpeed = 0.000000 m/s 2024-08-07T23:01:41.490Z,1723071701.490 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthRate = 0.400000 m/s 2024-08-07T23:01:41.515Z,1723071701.515 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachPitchLimit = 20.000000 arcdeg 2024-08-07T23:01:41.526Z,1723071701.526 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachSettleTimePreDive = 0.000000 min 2024-08-07T23:01:41.529Z,1723071701.529 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = 20.000000 min 2024-08-07T23:01:41.550Z,1723071701.550 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = 10.000000 min 2024-08-07T23:01:41.558Z,1723071701.558 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstTimeout = 45.000000 min 2024-08-07T23:01:41.571Z,1723071701.571 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MinEstTime = 10.000000 min 2024-08-07T23:01:41.583Z,1723071701.583 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = 0.250000 mm 2024-08-07T23:01:41.598Z,1723071701.598 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = 15.000000 cc 2024-08-07T23:01:41.610Z,1723071701.610 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.EstConfidence = 99.900002 % 2024-08-07T23:01:41.613Z,1723071701.613 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = 1.000000 m 2024-08-07T23:01:41.620Z,1723071701.620 [MissionManager](INFO): DefineArg sink:RunSink:BallastAndTrim.InsertMassDeadband = 0.250000 mm 2024-08-07T23:01:41.691Z,1723071701.691 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Construct. 2024-08-07T23:01:41.714Z,1723071701.714 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Construct Buoyancy. 2024-08-07T23:01:41.726Z,1723071701.726 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Construct. 2024-08-07T23:01:41.784Z,1723071701.784 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Construct Wait. 2024-08-07T23:01:41.800Z,1723071701.800 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Construct. 2024-08-07T23:01:41.825Z,1723071701.825 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Construct. 2024-08-07T23:01:41.867Z,1723071701.867 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute. 2024-08-07T23:01:41.879Z,1723071701.879 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Construct. 2024-08-07T23:01:41.891Z,1723071701.891 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Construct. 2024-08-07T23:01:41.928Z,1723071701.928 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Construct Wait. 2024-08-07T23:01:41.938Z,1723071701.938 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:E.Execute](DEBUG): Construct Execute. 2024-08-07T23:01:41.963Z,1723071701.963 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:G.](DEBUG): Construct BallastAndTrim. 2024-08-07T23:01:42.016Z,1723071702.016 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertDepthDeadband = reader:sink.DepthDeadband 2024-08-07T23:01:42.026Z,1723071702.026 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertApproachDepthTimeout = reader:sink.TargetDepthTimeout 2024-08-07T23:01:42.028Z,1723071702.028 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.InsertSettleTime = reader:sink.BTSettleTime 2024-08-07T23:01:42.038Z,1723071702.038 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstTimeout = reader:sink.EstimationTimeout 2024-08-07T23:01:42.039Z,1723071702.039 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MinEstTime = reader:sink.MinEstimationTime 2024-08-07T23:01:42.041Z,1723071702.041 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.MassEstErrorBound = reader:sink.MassEstimationErrorBound 2024-08-07T23:01:42.082Z,1723071702.082 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.BuoyEstErrorBound = reader:sink.BuoyEstimationErrorBound 2024-08-07T23:01:42.084Z,1723071702.084 [MissionManager](INFO): RedefineArg sink:RunSink:BallastAndTrim.EstConfidence = reader:sink.EstimationConfidence 2024-08-07T23:01:42.171Z,1723071702.171 [sink:Float_Up:A.Buoyancy](DEBUG): Construct Buoyancy. 2024-08-07T23:01:42.210Z,1723071702.210 [sink:Float_Up:B.Wait](DEBUG): Construct Wait. 2024-08-07T23:01:42.411Z,1723071702.411 [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 { MissionTimeout = 2 hour """ Maximum duration of mission. """ 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. """ WaitToFloat = 20 minute """ Timeout for reaching surface threshold on float ascent, vehicle will drive up when reached """ TargetDepthTimeout = 20 minute """ Maximum wait time for the vehicle to reach the target depth. """ DoBallastAndTrim = true """ 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. """ } timeout duration=MissionTimeout 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 call id="StartingMission" refId="NeedComms" aggregate RunSink { run in sequence 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 = MissionTimeout call refId="BallastAndTrim" } } aggregate Float_Up { """ 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" } 2024-08-07T23:01:42.412Z,1723071702.412 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/sink.tl id=sink 2024-08-07T23:01:44.395Z,1723071704.395 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240807T225801/Courier0006.lzma 2024-08-07T23:01:44.580Z,1723071704.580 [NAL9602](INFO): SBD MO Status=2, MOMSN=40381, MT Status=2, MTMSN=0 2024-08-07T23:01:44.580Z,1723071704.580 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-08-07T23:01:45.395Z,1723071705.395 [DataOverHttps](INFO): Moved sent file to Logs/20240807T225801/Courier0006.lzma.bak 2024-08-07T23:01:45.396Z,1723071705.396 [DataOverHttps](INFO): SBD MOMSN=21448275 2024-08-07T23:02:01.504Z,1723071721.504 [CommandExec](IMPORTANT): got command set sink.MissionTimeout 7 minute 2024-08-07T23:02:01.505Z,1723071721.505 [CommandExec](IMPORTANT): got command set sink.Depth 0.75 meter 2024-08-07T23:02:01.506Z,1723071721.506 [CommandExec](IMPORTANT): got command set sink.DepthDeadband .5 meter 2024-08-07T23:02:01.507Z,1723071721.507 [CommandExec](IMPORTANT): got command set sink.DoBallastAndTrim 0 bool 2024-08-07T23:02:01.507Z,1723071721.507 [CommandExec](IMPORTANT): got command set sink.MinAltitude .0001 meter 2024-08-07T23:02:01.508Z,1723071721.508 [CommandExec](IMPORTANT): got command set sink.MaxDepth 5 meter 2024-08-07T23:02:01.508Z,1723071721.508 [CommandExec](IMPORTANT): got command set sink.MinOffshore .00001 kilometer 2024-08-07T23:02:01.524Z,1723071721.524 [CommandExec](IMPORTANT): got command schedule "set OnDock.IfconfigInterval 3 min;run" 27jxq 2 2.000000 2024-08-07T23:02:01.525Z,1723071721.525 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=27jxq 2024-08-07T23:02:01.526Z,1723071721.526 [CommandExec](IMPORTANT): Scheduled #4 (#2 of 2 with id='27jxq'): "set OnDock.IfconfigInterval 3 min;run", AFTER MISSION 2024-08-07T23:02:19.072Z,1723071739.072 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240807T225801/Courier0009.lzma 2024-08-07T23:02:20.050Z,1723071740.050 [CommandExec](IMPORTANT): got command set sink:NeedComms.GPSTimeout 10 second 2024-08-07T23:02:20.051Z,1723071740.051 [CommandExec](IMPORTANT): got command set sink:NeedComms.CommsTimeout 10 second 2024-08-07T23:02:20.051Z,1723071740.051 [CommandExec](IMPORTANT): got command run 2024-08-07T23:02:20.055Z,1723071740.055 [CommandExec](IMPORTANT): Running 2024-08-07T23:02:20.072Z,1723071740.072 [DataOverHttps](INFO): Moved sent file to Logs/20240807T225801/Courier0009.lzma.bak 2024-08-07T23:02:20.072Z,1723071740.072 [DataOverHttps](INFO): SBD MOMSN=21448277 2024-08-07T23:02:20.216Z,1723071740.216 [Default] Stopped 2024-08-07T23:02:20.216Z,1723071740.216 [Default](DEBUG): Aggregate::uninitialize Default 2024-08-07T23:02:20.216Z,1723071740.216 [Default:B.GoToSurface] Stopped 2024-08-07T23:02:20.216Z,1723071740.216 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-07T23:02:20.216Z,1723071740.216 [Default:CheckIn] Stopped 2024-08-07T23:02:20.216Z,1723071740.216 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-07T23:02:20.217Z,1723071740.217 [Default:CheckIn:Read_Iridium] Stopped 2024-08-07T23:02:20.217Z,1723071740.217 [MissionManager](IMPORTANT): Started mission sink 2024-08-07T23:02:20.217Z,1723071740.217 [sink] Running Loop=1 2024-08-07T23:02:20.217Z,1723071740.217 [sink](DEBUG): Aggregate::initialize sink 2024-08-07T23:02:20.217Z,1723071740.217 [sink:Science] Running Loop=1 2024-08-07T23:02:20.217Z,1723071740.217 [sink:Science](DEBUG): Aggregate::initialize sink:Science 2024-08-07T23:02:20.217Z,1723071740.217 [sink:Science:A] Running Loop=1 2024-08-07T23:02:20.217Z,1723071740.217 [sink:Science:B] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:C] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:D] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:E] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:F] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:Read_Oil] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:PeakDetectChl] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:PeakDetectChl](DEBUG): Aggregate::initialize sink:Science:PeakDetectChl 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2024-08-07T23:02:20.226Z,1723071740.226 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2024-08-07T23:02:20.228Z,1723071740.228 [sink:Science:HighestChlPeakReport] Running Loop=1 2024-08-07T23:02:20.228Z,1723071740.228 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestChlPeakReport 2024-08-07T23:02:20.229Z,1723071740.229 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2024-08-07T23:02:20.229Z,1723071740.229 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2024-08-07T23:02:20.229Z,1723071740.229 [sink:Science:PeakDetectNO3] Running Loop=1 2024-08-07T23:02:20.229Z,1723071740.229 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sink:Science:PeakDetectNO3 2024-08-07T23:02:20.229Z,1723071740.229 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2024-08-07T23:02:20.234Z,1723071740.234 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2024-08-07T23:02:20.236Z,1723071740.236 [sink:Science:PeakDetectOil] Running Loop=1 2024-08-07T23:02:20.236Z,1723071740.236 [sink:Science:PeakDetectOil](DEBUG): Aggregate::initialize sink:Science:PeakDetectOil 2024-08-07T23:02:20.236Z,1723071740.236 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2024-08-07T23:02:20.236Z,1723071740.236 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2024-08-07T23:02:20.243Z,1723071740.243 [sink:Science:HighestOilPeakReport] Running Loop=1 2024-08-07T23:02:20.243Z,1723071740.243 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestOilPeakReport 2024-08-07T23:02:20.243Z,1723071740.243 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2024-08-07T23:02:20.243Z,1723071740.243 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2024-08-07T23:02:20.243Z,1723071740.243 [sink:Science:PeakDetectFDOM] Running Loop=1 2024-08-07T23:02:20.244Z,1723071740.244 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sink:Science:PeakDetectFDOM 2024-08-07T23:02:20.244Z,1723071740.244 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2024-08-07T23:02:20.244Z,1723071740.244 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2024-08-07T23:02:20.245Z,1723071740.245 [sink:Science:PeakDetectSalinity] Running Loop=1 2024-08-07T23:02:20.245Z,1723071740.245 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize sink:Science:PeakDetectSalinity 2024-08-07T23:02:20.250Z,1723071740.250 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2024-08-07T23:02:20.250Z,1723071740.250 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2024-08-07T23:02:20.251Z,1723071740.251 [sink:Science:HighestSaltPeakReport] Running Loop=1 2024-08-07T23:02:20.251Z,1723071740.251 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize sink:Science:HighestSaltPeakReport 2024-08-07T23:02:20.252Z,1723071740.252 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2024-08-07T23:02:20.252Z,1723071740.252 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2024-08-07T23:02:20.253Z,1723071740.253 [sink:Science:ChlThreshTrigger] Running Loop=1 2024-08-07T23:02:20.253Z,1723071740.253 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::initialize sink:Science:ChlThreshTrigger 2024-08-07T23:02:20.253Z,1723071740.253 [sink:Science:ChlThreshTrigger:A.ValueDetect] Running Loop=1 2024-08-07T23:02:20.253Z,1723071740.253 [sink:Science:ChlThreshTrigger:A.ValueDetect](INFO): Initialize. 2024-08-07T23:02:20.253Z,1723071740.253 [sink:Science:OceanCurrent] Running Loop=1 2024-08-07T23:02:20.258Z,1723071740.258 [sink:Science:OceanCurrent](DEBUG): Aggregate::initialize sink:Science:OceanCurrent 2024-08-07T23:02:20.258Z,1723071740.258 [sink:Science:OceanCurrent:A.] Running Loop=1 2024-08-07T23:02:20.258Z,1723071740.258 [sink:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2024-08-07T23:02:20.258Z,1723071740.258 [sink:StandardEnvelopes] Running Loop=1 2024-08-07T23:02:20.258Z,1723071740.258 [sink:StandardEnvelopes](DEBUG): Aggregate::initialize sink:StandardEnvelopes 2024-08-07T23:02:20.258Z,1723071740.258 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2024-08-07T23:02:20.258Z,1723071740.258 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2024-08-07T23:02:20.258Z,1723071740.258 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2024-08-07T23:02:20.259Z,1723071740.259 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2024-08-07T23:02:20.259Z,1723071740.259 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2024-08-07T23:02:20.259Z,1723071740.259 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2024-08-07T23:02:20.259Z,1723071740.259 [sink:BackseatDriver] Running Loop=1 2024-08-07T23:02:20.259Z,1723071740.259 [sink:BackseatDriver](DEBUG): Aggregate::initialize sink:BackseatDriver 2024-08-07T23:02:20.259Z,1723071740.259 [sink:BackseatDriver:A.BackseatDriver] Running Loop=1 2024-08-07T23:02:20.259Z,1723071740.259 [sink:PowerOnly] Running Loop=1 2024-08-07T23:02:20.259Z,1723071740.259 [sink:PowerOnly](DEBUG): Aggregate::initialize sink:PowerOnly 2024-08-07T23:02:20.259Z,1723071740.259 [sink:PowerOnly:A] Running Loop=1 2024-08-07T23:02:20.259Z,1723071740.259 [sink:PowerOnly:B] Running Loop=1 2024-08-07T23:02:20.260Z,1723071740.260 [sink:PowerOnly:C] Running Loop=1 2024-08-07T23:02:20.260Z,1723071740.260 [sink:PowerOnly:D] Running Loop=1 2024-08-07T23:02:20.260Z,1723071740.260 [sink:PowerOnly:E.Wait] Running Loop=1 2024-08-07T23:02:20.260Z,1723071740.260 [sink:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2024-08-07T23:02:20.260Z,1723071740.260 [sink:C] Running Loop=1 2024-08-07T23:02:20.261Z,1723071740.261 [sink:PowerOnly] Running Loop=1 2024-08-07T23:02:20.261Z,1723071740.261 [sink:PowerOnly:D] Stopped 2024-08-07T23:02:20.261Z,1723071740.261 [sink:PowerOnly:C] Stopped 2024-08-07T23:02:20.261Z,1723071740.261 [sink:PowerOnly:B] Stopped 2024-08-07T23:02:20.261Z,1723071740.261 [sink:PowerOnly:A] Stopped 2024-08-07T23:02:20.261Z,1723071740.261 [sink:BackseatDriver] Running Loop=1 2024-08-07T23:02:20.266Z,1723071740.266 [sink:StandardEnvelopes] Running Loop=1 2024-08-07T23:02:20.266Z,1723071740.266 [sink:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2024-08-07T23:02:20.266Z,1723071740.266 [sink:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE 2024-08-07T23:02:20.282Z,1723071740.282 [sink:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2024-08-07T23:02:20.283Z,1723071740.283 [sink:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2024-08-07T23:02:20.284Z,1723071740.284 [sink:C] Stopped 2024-08-07T23:02:20.284Z,1723071740.284 [sink:E] Running Loop=1 2024-08-07T23:02:20.284Z,1723071740.284 [sink:Science] Running Loop=1 2024-08-07T23:02:20.285Z,1723071740.285 [sink:Science:ChlThreshTrigger] Stopped 2024-08-07T23:02:20.285Z,1723071740.285 [sink:Science:ChlThreshTrigger](DEBUG): Aggregate::uninitialize sink:Science:ChlThreshTrigger 2024-08-07T23:02:20.285Z,1723071740.285 [sink:Science:ChlThreshTrigger:A.ValueDetect] Stopped 2024-08-07T23:02:20.285Z,1723071740.285 [sink:Science:ChlThreshTrigger:A.ValueDetect](DEBUG): Uninitialize. 2024-08-07T23:02:20.285Z,1723071740.285 [sink:Science:HighestSaltPeakReport] Stopped 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestSaltPeakReport 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:PeakDetectSalinity] Stopped 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectSalinity 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:PeakDetectFDOM] Stopped 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectFDOM 2024-08-07T23:02:20.298Z,1723071740.298 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:HighestOilPeakReport] Stopped 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestOilPeakReport 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectOil] Stopped 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectOil 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectNO3] Stopped 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectNO3 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2024-08-07T23:02:20.299Z,1723071740.299 [sink:Science:HighestChlPeakReport] Stopped 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sink:Science:HighestChlPeakReport 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:PeakDetectChl] Stopped 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sink:Science:PeakDetectChl 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2024-08-07T23:02:20.300Z,1723071740.300 [sink:Science:OceanCurrent:A.] Running Loop=1 2024-08-07T23:02:20.306Z,1723071740.306 [sink:Science:Read_Oil] Stopped 2024-08-07T23:02:20.306Z,1723071740.306 [sink:Science:F] Running Loop=1 2024-08-07T23:02:20.307Z,1723071740.307 [sink:Science:F](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.average_bioluminescence 2024-08-07T23:02:20.307Z,1723071740.307 [sink:Science:E] Running Loop=1 2024-08-07T23:02:20.308Z,1723071740.308 [sink:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2024-08-07T23:02:20.308Z,1723071740.308 [sink:Science:D] Stopped 2024-08-07T23:02:20.308Z,1723071740.308 [sink:Science:C] Running Loop=1 2024-08-07T23:02:20.309Z,1723071740.309 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2024-08-07T23:02:20.309Z,1723071740.309 [sink:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2024-08-07T23:02:20.314Z,1723071740.314 [sink:Science:B] Running Loop=1 2024-08-07T23:02:20.314Z,1723071740.314 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2024-08-07T23:02:20.315Z,1723071740.315 [sink:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2024-08-07T23:02:20.315Z,1723071740.315 [sink:Science:A] Stopped 2024-08-07T23:02:20.319Z,1723071740.319 [HorizontalControl](DEBUG): kpHeading = 0.400000 2024-08-07T23:02:20.320Z,1723071740.320 [HorizontalControl](DEBUG): kiHeading = 0.001000 2024-08-07T23:02:20.320Z,1723071740.320 [HorizontalControl](DEBUG): kdHeading = 0.050000 2024-08-07T23:02:20.440Z,1723071740.440 [WetLabsBB2FL](INFO): Powering up 2024-08-07T23:02:20.577Z,1723071740.577 [sink:E] Stopped 2024-08-07T23:02:20.577Z,1723071740.577 [sink:F] Running Loop=1 2024-08-07T23:02:21.007Z,1723071741.007 [WetLabsUBAT](INFO): Powering up 2024-08-07T23:02:21.035Z,1723071741.035 [sink:F] Stopped 2024-08-07T23:02:21.035Z,1723071741.035 [sink:G] Running Loop=1 2024-08-07T23:02:21.380Z,1723071741.380 [sink:G] Stopped 2024-08-07T23:02:21.380Z,1723071741.380 [sink:StartingMission] Running Loop=1 2024-08-07T23:02:21.380Z,1723071741.380 [sink:StartingMission](DEBUG): Aggregate::initialize sink:StartingMission 2024-08-07T23:02:21.953Z,1723071741.953 [sink:NeedComms] Running Loop=1 2024-08-07T23:02:21.953Z,1723071741.953 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms 2024-08-07T23:02:21.953Z,1723071741.953 [sink:NeedComms:B.GoToSurface] Running Loop=1 2024-08-07T23:02:21.953Z,1723071741.953 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-07T23:02:21.954Z,1723071741.954 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2024-08-07T23:02:21.954Z,1723071741.954 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2024-08-07T23:02:21.955Z,1723071741.955 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2024-08-07T23:02:21.955Z,1723071741.955 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2024-08-07T23:02:21.955Z,1723071741.955 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-07T23:02:21.956Z,1723071741.956 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-07T23:02:21.956Z,1723071741.956 [sink:NeedComms:A] Running Loop=1 2024-08-07T23:02:21.957Z,1723071741.957 [sink:NeedComms:A](INFO): last time_fix was: 1723071637.000000 second since 1970/01/01T00:00:00Z 2024-08-07T23:02:21.957Z,1723071741.957 [sink:NeedComms:A] Stopped 2024-08-07T23:02:22.323Z,1723071742.323 [sink:NeedComms:C] Running Loop=1 2024-08-07T23:02:22.715Z,1723071742.715 [sink:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-08-07T23:02:23.648Z,1723071743.648 [CTD_Seabird](ERROR): Failed to parse device response: 2024-08-07T23:02:24.798Z,1723071744.798 [NAL9602](INFO): SBD MO Status=2, MOMSN=40381, MT Status=2, MTMSN=0 2024-08-07T23:02:24.798Z,1723071744.798 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-08-07T23:02:31.090Z,1723071751.090 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:02:31.171Z,1723071751.171 [WetLabsUBAT](FAULT): UBAT flow rate is below the specified threshold of 0.05 l/s. 2024-08-07T23:02:32.697Z,1723071752.697 [sink:NeedComms:C](INFO): Timed out from 2024-08-07T23:02:22.3Z 2024-08-07T23:02:32.697Z,1723071752.697 [sink:NeedComms:C:A_Timeout] Running Loop=1 2024-08-07T23:02:32.697Z,1723071752.697 [sink:NeedComms:C:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:C:A_Timeout 2024-08-07T23:02:32.697Z,1723071752.697 [sink:NeedComms:C:A_Timeout:A] Running Loop=1 2024-08-07T23:02:32.702Z,1723071752.702 [sink:NeedComms:C:A_Timeout:A](IMPORTANT): first GPS update timeout 2024-08-07T23:02:32.702Z,1723071752.702 [sink:NeedComms:C:A_Timeout:A] Stopped 2024-08-07T23:02:32.702Z,1723071752.702 [sink:NeedComms:C:A_Timeout](INFO): Completed sink:NeedComms:C:A_Timeout 2024-08-07T23:02:32.702Z,1723071752.702 [sink:NeedComms:C] Stopped 2024-08-07T23:02:32.703Z,1723071752.703 [sink:NeedComms:D] Running Loop=1 2024-08-07T23:02:33.271Z,1723071753.271 [sink:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-08-07T23:02:39.867Z,1723071759.867 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240807T225801/Courier0012.lzma 2024-08-07T23:02:40.868Z,1723071760.868 [DataOverHttps](INFO): Moved sent file to Logs/20240807T225801/Courier0012.lzma.bak 2024-08-07T23:02:40.869Z,1723071760.869 [DataOverHttps](INFO): SBD MOMSN=21448279 2024-08-07T23:02:42.820Z,1723071762.820 [sink:NeedComms:D](INFO): Timed out from 2024-08-07T23:02:32.7Z 2024-08-07T23:02:42.820Z,1723071762.820 [sink:NeedComms:D:A_Timeout] Running Loop=1 2024-08-07T23:02:42.820Z,1723071762.820 [sink:NeedComms:D:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:D:A_Timeout 2024-08-07T23:02:42.820Z,1723071762.820 [sink:NeedComms:D:A_Timeout:A] Running Loop=1 2024-08-07T23:02:42.820Z,1723071762.820 [sink:NeedComms:D:A_Timeout:A](IMPORTANT): Comms timed out after 0.166667 min minutes 2024-08-07T23:02:42.821Z,1723071762.821 [sink:NeedComms:D:A_Timeout:A] Stopped 2024-08-07T23:02:42.821Z,1723071762.821 [sink:NeedComms:D:A_Timeout](INFO): Completed sink:NeedComms:D:A_Timeout 2024-08-07T23:02:42.821Z,1723071762.821 [sink:NeedComms:D] Stopped 2024-08-07T23:02:42.821Z,1723071762.821 [sink:NeedComms:E] Running Loop=1 2024-08-07T23:02:43.308Z,1723071763.308 [sink:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-08-07T23:02:51.974Z,1723071771.974 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:02:53.016Z,1723071773.016 [sink:NeedComms:E](INFO): Timed out from 2024-08-07T23:02:42.8Z 2024-08-07T23:02:53.017Z,1723071773.017 [sink:NeedComms:E:A_Timeout] Running Loop=1 2024-08-07T23:02:53.017Z,1723071773.017 [sink:NeedComms:E:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:E:A_Timeout 2024-08-07T23:02:53.017Z,1723071773.017 [sink:NeedComms:E:A_Timeout:A] Running Loop=1 2024-08-07T23:02:53.017Z,1723071773.017 [sink:NeedComms:E:A_Timeout:A](IMPORTANT): second GPS update timeout 2024-08-07T23:02:53.017Z,1723071773.017 [sink:NeedComms:E:A_Timeout:A] Stopped 2024-08-07T23:02:53.017Z,1723071773.017 [sink:NeedComms:E:A_Timeout](INFO): Completed sink:NeedComms:E:A_Timeout 2024-08-07T23:02:53.018Z,1723071773.018 [sink:NeedComms:E] Stopped 2024-08-07T23:02:53.019Z,1723071773.019 [sink:NeedComms](INFO): Completed sink:NeedComms 2024-08-07T23:02:53.019Z,1723071773.019 [sink:NeedComms] Stopped 2024-08-07T23:02:53.019Z,1723071773.019 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms 2024-08-07T23:02:53.019Z,1723071773.019 [sink:NeedComms:B.GoToSurface] Stopped 2024-08-07T23:02:53.020Z,1723071773.020 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-07T23:02:53.429Z,1723071773.429 [sink:StartingMission](INFO): Completed sink:StartingMission 2024-08-07T23:02:53.429Z,1723071773.429 [sink:StartingMission] Stopped 2024-08-07T23:02:53.429Z,1723071773.429 [sink:StartingMission](DEBUG): Aggregate::uninitialize sink:StartingMission 2024-08-07T23:02:53.429Z,1723071773.429 [sink:RunSink] Running Loop=1 2024-08-07T23:02:53.429Z,1723071773.429 [sink:RunSink](DEBUG): Aggregate::initialize sink:RunSink 2024-08-07T23:02:53.430Z,1723071773.430 [sink:RunSink:RunBallastAndTrim] Running Loop=1 2024-08-07T23:02:53.430Z,1723071773.430 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:RunBallastAndTrim 2024-08-07T23:02:53.430Z,1723071773.430 [sink:RunSink:RunBallastAndTrim:A] Running Loop=1 2024-08-07T23:02:53.554Z,1723071773.554 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2024-08-07T23:02:53.800Z,1723071773.800 [sink:RunSink:RunBallastAndTrim] Stopped 2024-08-07T23:02:53.800Z,1723071773.800 [sink:RunSink:RunBallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:RunBallastAndTrim 2024-08-07T23:02:53.800Z,1723071773.800 [sink:RunSink:RunBallastAndTrim:A] Stopped 2024-08-07T23:02:53.800Z,1723071773.800 [sink:RunSink:JustSink] Running Loop=1 2024-08-07T23:02:53.800Z,1723071773.800 [sink:RunSink:JustSink](DEBUG): Aggregate::initialize sink:RunSink:JustSink 2024-08-07T23:02:53.800Z,1723071773.800 [sink:RunSink:JustSink:A] Running Loop=1 2024-08-07T23:02:54.224Z,1723071774.224 [sink:RunSink:JustSink:A] Stopped 2024-08-07T23:02:54.225Z,1723071774.225 [sink:RunSink:JustSink:B] Running Loop=1 2024-08-07T23:02:54.689Z,1723071774.689 [sink:RunSink:JustSink:B] Stopped 2024-08-07T23:02:54.689Z,1723071774.689 [sink:RunSink:JustSink:C] Running Loop=1 2024-08-07T23:02:54.698Z,1723071774.698 [sink:RunSink:JustSink:C](DEBUG): Aggregate::initialize sink:RunSink:JustSink:C 2024-08-07T23:02:55.043Z,1723071775.043 [sink:RunSink:BallastAndTrim] Running Loop=1 2024-08-07T23:02:55.043Z,1723071775.043 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim 2024-08-07T23:02:55.043Z,1723071775.043 [sink:RunSink:BallastAndTrim:A] Running Loop=1 2024-08-07T23:02:55.043Z,1723071775.043 [sink:RunSink:BallastAndTrim:B] Running Loop=1 2024-08-07T23:02:55.043Z,1723071775.043 [sink:RunSink:BallastAndTrim:C] Running Loop=1 2024-08-07T23:02:55.043Z,1723071775.043 [sink:RunSink:BallastAndTrim:D] Running Loop=1 2024-08-07T23:02:55.043Z,1723071775.043 [sink:RunSink:BallastAndTrim:E] Running Loop=1 2024-08-07T23:02:55.044Z,1723071775.044 [sink:RunSink:BallastAndTrim:F] Running Loop=1 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:F](INFO): Going to target depth. Speed set to 0.000000 m/s 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:F] Stopped 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Running Loop=1 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Running Loop=1 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold 2024-08-07T23:02:55.054Z,1723071775.054 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Running Loop=1 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Initialize. 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Running Loop=1 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Initialize Buoyancy Component. 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Running Loop=1 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Initialize. 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Running Loop=1 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Running Loop=1 2024-08-07T23:02:55.055Z,1723071775.055 [sink:RunSink:BallastAndTrim:E] Running Loop=1 2024-08-07T23:02:55.056Z,1723071775.056 [sink:RunSink:BallastAndTrim:D] Running Loop=1 2024-08-07T23:02:55.056Z,1723071775.056 [sink:RunSink:BallastAndTrim:C] Running Loop=1 2024-08-07T23:02:55.056Z,1723071775.056 [sink:RunSink:BallastAndTrim:B] Running Loop=1 2024-08-07T23:02:55.056Z,1723071775.056 [sink:RunSink:BallastAndTrim:A] Running Loop=1 2024-08-07T23:02:55.625Z,1723071775.625 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A](INFO): Waiting for 0.000000 min while pumping down to neutral. 2024-08-07T23:02:55.625Z,1723071775.625 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Stopped 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Running Loop=1 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Initialize Wait Component. 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold] Stopped 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Stopped 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Stopped 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Stopped 2024-08-07T23:02:55.638Z,1723071775.638 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2024-08-07T23:02:55.974Z,1723071775.974 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](INFO): Done Waiting. 2024-08-07T23:02:55.974Z,1723071775.974 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait] Stopped 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Uninitialize Wait Component. 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive] Stopped 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:WaitPreDive 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Running Loop=1 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2024-08-07T23:02:55.975Z,1723071775.975 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Initialize. 2024-08-07T23:02:55.976Z,1723071775.976 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Running Loop=1 2024-08-07T23:02:56.431Z,1723071776.431 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2024-08-07T23:02:56.431Z,1723071776.431 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A](INFO): Moving to 0.750000 m 2024-08-07T23:02:56.432Z,1723071776.432 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Stopped 2024-08-07T23:02:56.432Z,1723071776.432 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Running Loop=1 2024-08-07T23:02:56.432Z,1723071776.432 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Initialize. 2024-08-07T23:03:01.817Z,1723071781.817 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240807T225801/Courier0015.lzma 2024-08-07T23:03:02.820Z,1723071782.820 [DataOverHttps](INFO): Moved sent file to Logs/20240807T225801/Courier0015.lzma.bak 2024-08-07T23:03:02.820Z,1723071782.820 [DataOverHttps](INFO): SBD MOMSN=21448284 2024-08-07T23:03:03.823Z,1723071783.823 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:03:11.891Z,1723071791.891 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2024-08-07T23:03:12.852Z,1723071792.852 [CTD_Seabird](ERROR): Failed to parse device response: 7,4.72334,5844.91 2024-08-07T23:03:14.314Z,1723071794.314 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:03:25.022Z,1723071805.022 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:03:33.044Z,1723071813.044 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude. Device response is::BD, +0.73, +0.02-0.45, 8.97, 0.00 2024-08-07T23:03:36.242Z,1723071816.242 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:03:46.938Z,1723071826.938 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:03:57.874Z,1723071837.874 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:04:07.838Z,1723071847.838 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2024-08-07T23:04:12.290Z,1723071852.290 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:04:44.035Z,1723071884.035 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:04:45.072Z,1723071885.072 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Stopped 2024-08-07T23:04:45.073Z,1723071885.073 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth 2024-08-07T23:04:45.073Z,1723071885.073 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth] Stopped 2024-08-07T23:04:45.073Z,1723071885.073 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth 2024-08-07T23:04:45.073Z,1723071885.073 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Stopped 2024-08-07T23:04:45.074Z,1723071885.074 [sink:RunSink:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Uninitialize. 2024-08-07T23:04:45.074Z,1723071885.074 [sink:RunSink:BallastAndTrim:GoToTargetDepth](INFO): Completed sink:RunSink:BallastAndTrim:GoToTargetDepth 2024-08-07T23:04:45.074Z,1723071885.074 [sink:RunSink:BallastAndTrim:GoToTargetDepth] Stopped 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:GoToTargetDepth 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:GoToTargetDepth:A] Stopped 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth] Running Loop=1 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth](DEBUG): Aggregate::initialize sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Running Loop=1 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Initialize. 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Running Loop=1 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Initialize. 2024-08-07T23:04:45.075Z,1723071885.075 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:C] Running Loop=1 2024-08-07T23:04:45.577Z,1723071885.577 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:C](INFO): Waiting for the vehicle to settle. Depth = 0.781979 m 2024-08-07T23:04:45.577Z,1723071885.577 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:C] Stopped 2024-08-07T23:04:45.577Z,1723071885.577 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait] Running Loop=1 2024-08-07T23:04:45.577Z,1723071885.577 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Initialize Wait Component. 2024-08-07T23:04:45.577Z,1723071885.577 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Running Loop=1 2024-08-07T23:04:45.577Z,1723071885.577 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Running Loop=1 2024-08-07T23:04:48.378Z,1723071888.378 [RDI_Pathfinder](ERROR): only read 3 of 4 data items for water velocity. Device response is::WS,-32768,-32768,-327W -15,A 2024-08-07T23:05:12.147Z,1723071912.147 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.859325 2024-08-07T23:05:13.151Z,1723071913.151 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:05:32.338Z,1723071932.338 [WetLabsUBAT](ERROR): Failed to parse incomplete device message. 2024-08-07T23:05:40.215Z,1723071940.215 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-08-07T23:05:43.274Z,1723071943.274 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-08-07T23:05:44.278Z,1723071944.278 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:06:10.768Z,1723071970.768 [NAL9602](INFO): Not Powering down - fast GPS 2024-08-07T23:06:14.398Z,1723071974.398 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-08-07T23:06:15.402Z,1723071975.402 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:06:45.530Z,1723072005.530 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-08-07T23:06:46.535Z,1723072006.535 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:07:16.655Z,1723072036.655 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-08-07T23:07:17.658Z,1723072037.658 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:07:42.943Z,1723072062.943 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error. Device response is::TS00, 98.93, 82.04, 91.69, 89.28 2024-08-07T23:07:47.802Z,1723072067.802 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-08-07T23:07:48.806Z,1723072068.806 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:07:56.156Z,1723072076.156 [sink:NeedComms] Running Loop=1 2024-08-07T23:07:56.157Z,1723072076.157 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms 2024-08-07T23:07:56.157Z,1723072076.157 [sink:NeedComms:B.GoToSurface] Running Loop=1 2024-08-07T23:07:56.157Z,1723072076.157 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-07T23:07:56.157Z,1723072076.157 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2024-08-07T23:07:56.158Z,1723072076.158 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2024-08-07T23:07:56.159Z,1723072076.159 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2024-08-07T23:07:56.159Z,1723072076.159 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2024-08-07T23:07:56.159Z,1723072076.159 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-07T23:07:56.160Z,1723072076.160 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-07T23:07:56.160Z,1723072076.160 [sink:NeedComms:A] Running Loop=1 2024-08-07T23:07:56.161Z,1723072076.161 [sink:NeedComms:A](INFO): last time_fix was: 1723071637.000000 second since 1970/01/01T00:00:00Z 2024-08-07T23:07:56.162Z,1723072076.162 [sink:NeedComms:A] Stopped 2024-08-07T23:07:56.560Z,1723072076.560 [sink:NeedComms:C] Running Loop=1 2024-08-07T23:08:06.695Z,1723072086.695 [sink:NeedComms:C](INFO): Timed out from 2024-08-07T23:07:56.6Z 2024-08-07T23:08:06.695Z,1723072086.695 [sink:NeedComms:C:A_Timeout] Running Loop=1 2024-08-07T23:08:06.695Z,1723072086.695 [sink:NeedComms:C:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:C:A_Timeout 2024-08-07T23:08:06.695Z,1723072086.695 [sink:NeedComms:C:A_Timeout:A] Running Loop=1 2024-08-07T23:08:06.696Z,1723072086.696 [sink:NeedComms:C:A_Timeout:A](IMPORTANT): first GPS update timeout 2024-08-07T23:08:06.696Z,1723072086.696 [sink:NeedComms:C:A_Timeout:A] Stopped 2024-08-07T23:08:06.696Z,1723072086.696 [sink:NeedComms:C:A_Timeout](INFO): Completed sink:NeedComms:C:A_Timeout 2024-08-07T23:08:06.696Z,1723072086.696 [sink:NeedComms:C] Stopped 2024-08-07T23:08:06.696Z,1723072086.696 [sink:NeedComms:D] Running Loop=1 2024-08-07T23:08:17.072Z,1723072097.072 [sink:NeedComms:D](INFO): Timed out from 2024-08-07T23:08:06.7Z 2024-08-07T23:08:17.073Z,1723072097.073 [sink:NeedComms:D:A_Timeout] Running Loop=1 2024-08-07T23:08:17.073Z,1723072097.073 [sink:NeedComms:D:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:D:A_Timeout 2024-08-07T23:08:17.073Z,1723072097.073 [sink:NeedComms:D:A_Timeout:A] Running Loop=1 2024-08-07T23:08:17.073Z,1723072097.073 [sink:NeedComms:D:A_Timeout:A](IMPORTANT): Comms timed out after 0.166667 min minutes 2024-08-07T23:08:17.073Z,1723072097.073 [sink:NeedComms:D:A_Timeout:A] Stopped 2024-08-07T23:08:17.073Z,1723072097.073 [sink:NeedComms:D:A_Timeout](INFO): Completed sink:NeedComms:D:A_Timeout 2024-08-07T23:08:17.074Z,1723072097.074 [sink:NeedComms:D] Stopped 2024-08-07T23:08:17.074Z,1723072097.074 [sink:NeedComms:E] Running Loop=1 2024-08-07T23:08:18.930Z,1723072098.930 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-08-07T23:08:19.934Z,1723072099.934 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:08:27.474Z,1723072107.474 [sink:NeedComms:E](INFO): Timed out from 2024-08-07T23:08:17.1Z 2024-08-07T23:08:27.474Z,1723072107.474 [sink:NeedComms:E:A_Timeout] Running Loop=1 2024-08-07T23:08:27.474Z,1723072107.474 [sink:NeedComms:E:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:E:A_Timeout 2024-08-07T23:08:27.475Z,1723072107.475 [sink:NeedComms:E:A_Timeout:A] Running Loop=1 2024-08-07T23:08:27.475Z,1723072107.475 [sink:NeedComms:E:A_Timeout:A](IMPORTANT): second GPS update timeout 2024-08-07T23:08:27.475Z,1723072107.475 [sink:NeedComms:E:A_Timeout:A] Stopped 2024-08-07T23:08:27.475Z,1723072107.475 [sink:NeedComms:E:A_Timeout](INFO): Completed sink:NeedComms:E:A_Timeout 2024-08-07T23:08:27.475Z,1723072107.475 [sink:NeedComms:E] Stopped 2024-08-07T23:08:27.476Z,1723072107.476 [sink:NeedComms](INFO): Completed sink:NeedComms 2024-08-07T23:08:27.476Z,1723072107.476 [sink:NeedComms] Stopped 2024-08-07T23:08:27.476Z,1723072107.476 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms 2024-08-07T23:08:27.476Z,1723072107.476 [sink:NeedComms:B.GoToSurface] Stopped 2024-08-07T23:08:27.476Z,1723072107.476 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-07T23:08:28.824Z,1723072108.824 [sink:NeedComms] Running Loop=1 2024-08-07T23:08:28.824Z,1723072108.824 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms 2024-08-07T23:08:28.824Z,1723072108.824 [sink:NeedComms:B.GoToSurface] Running Loop=1 2024-08-07T23:08:28.824Z,1723072108.824 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-07T23:08:28.825Z,1723072108.825 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2024-08-07T23:08:28.825Z,1723072108.825 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2024-08-07T23:08:28.825Z,1723072108.825 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2024-08-07T23:08:28.826Z,1723072108.826 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2024-08-07T23:08:28.826Z,1723072108.826 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-07T23:08:28.827Z,1723072108.827 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-07T23:08:28.827Z,1723072108.827 [sink:NeedComms:A] Running Loop=1 2024-08-07T23:08:28.828Z,1723072108.828 [sink:NeedComms:A](INFO): last time_fix was: 1723071637.000000 second since 1970/01/01T00:00:00Z 2024-08-07T23:08:28.828Z,1723072108.828 [sink:NeedComms:A] Stopped 2024-08-07T23:08:29.212Z,1723072109.212 [sink:NeedComms:C] Running Loop=1 2024-08-07T23:08:29.616Z,1723072109.616 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-08-07T23:08:29.698Z,1723072109.698 [NAL9602](ERROR): received: +CSQ:0 OK381, 2, 0, 0, 0 OK 2024-08-07T23:08:39.539Z,1723072119.539 [sink:NeedComms:C](INFO): Timed out from 2024-08-07T23:08:29.2Z 2024-08-07T23:08:39.539Z,1723072119.539 [sink:NeedComms:C:A_Timeout] Running Loop=1 2024-08-07T23:08:39.539Z,1723072119.539 [sink:NeedComms:C:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:C:A_Timeout 2024-08-07T23:08:39.540Z,1723072119.540 [sink:NeedComms:C:A_Timeout:A] Running Loop=1 2024-08-07T23:08:39.540Z,1723072119.540 [sink:NeedComms:C:A_Timeout:A](IMPORTANT): first GPS update timeout 2024-08-07T23:08:39.540Z,1723072119.540 [sink:NeedComms:C:A_Timeout:A] Stopped 2024-08-07T23:08:39.540Z,1723072119.540 [sink:NeedComms:C:A_Timeout](INFO): Completed sink:NeedComms:C:A_Timeout 2024-08-07T23:08:39.540Z,1723072119.540 [sink:NeedComms:C] Stopped 2024-08-07T23:08:39.540Z,1723072119.540 [sink:NeedComms:D] Running Loop=1 2024-08-07T23:08:49.854Z,1723072129.854 [sink:NeedComms:D](INFO): Timed out from 2024-08-07T23:08:39.5Z 2024-08-07T23:08:49.855Z,1723072129.855 [sink:NeedComms:D:A_Timeout] Running Loop=1 2024-08-07T23:08:49.855Z,1723072129.855 [sink:NeedComms:D:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:D:A_Timeout 2024-08-07T23:08:49.855Z,1723072129.855 [sink:NeedComms:D:A_Timeout:A] Running Loop=1 2024-08-07T23:08:49.855Z,1723072129.855 [sink:NeedComms:D:A_Timeout:A](IMPORTANT): Comms timed out after 0.166667 min minutes 2024-08-07T23:08:49.855Z,1723072129.855 [sink:NeedComms:D:A_Timeout:A] Stopped 2024-08-07T23:08:49.855Z,1723072129.855 [sink:NeedComms:D:A_Timeout](INFO): Completed sink:NeedComms:D:A_Timeout 2024-08-07T23:08:49.856Z,1723072129.856 [sink:NeedComms:D] Stopped 2024-08-07T23:08:49.856Z,1723072129.856 [sink:NeedComms:E] Running Loop=1 2024-08-07T23:08:50.059Z,1723072130.059 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2024-08-07T23:08:51.062Z,1723072131.062 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E](INFO): Timed out from 2024-08-07T23:08:49.9Z 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E:A_Timeout] Running Loop=1 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:E:A_Timeout 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E:A_Timeout:A] Running Loop=1 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E:A_Timeout:A](IMPORTANT): second GPS update timeout 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E:A_Timeout:A] Stopped 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E:A_Timeout](INFO): Completed sink:NeedComms:E:A_Timeout 2024-08-07T23:08:59.980Z,1723072139.980 [sink:NeedComms:E] Stopped 2024-08-07T23:08:59.981Z,1723072139.981 [sink:NeedComms](INFO): Completed sink:NeedComms 2024-08-07T23:08:59.981Z,1723072139.981 [sink:NeedComms] Stopped 2024-08-07T23:08:59.981Z,1723072139.981 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms 2024-08-07T23:08:59.982Z,1723072139.982 [sink:NeedComms:B.GoToSurface] Stopped 2024-08-07T23:08:59.982Z,1723072139.982 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-07T23:09:00.501Z,1723072140.501 [sink:NeedComms] Running Loop=1 2024-08-07T23:09:00.501Z,1723072140.501 [sink:NeedComms](DEBUG): Aggregate::initialize sink:NeedComms 2024-08-07T23:09:00.501Z,1723072140.501 [sink:NeedComms:B.GoToSurface] Running Loop=1 2024-08-07T23:09:00.501Z,1723072140.501 [sink:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-07T23:09:00.503Z,1723072140.503 [sink:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2024-08-07T23:09:00.503Z,1723072140.503 [sink:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2024-08-07T23:09:00.504Z,1723072140.504 [sink:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2024-08-07T23:09:00.505Z,1723072140.505 [sink:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2024-08-07T23:09:00.505Z,1723072140.505 [sink:NeedComms:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-07T23:09:00.505Z,1723072140.505 [sink:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-07T23:09:00.505Z,1723072140.505 [sink:NeedComms:A] Running Loop=1 2024-08-07T23:09:00.515Z,1723072140.515 [sink:NeedComms:A](INFO): last time_fix was: 1723071637.000000 second since 1970/01/01T00:00:00Z 2024-08-07T23:09:00.515Z,1723072140.515 [sink:NeedComms:A] Stopped 2024-08-07T23:09:00.627Z,1723072140.627 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003015 2024-08-07T23:09:00.996Z,1723072140.996 [sink:NeedComms:C] Running Loop=1 2024-08-07T23:09:01.628Z,1723072141.628 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:09:11.021Z,1723072151.021 [sink:NeedComms:C](INFO): Timed out from 2024-08-07T23:09:00.0Z 2024-08-07T23:09:11.021Z,1723072151.021 [sink:NeedComms:C:A_Timeout] Running Loop=1 2024-08-07T23:09:11.021Z,1723072151.021 [sink:NeedComms:C:A_Timeout](DEBUG): Aggregate::initialize sink:NeedComms:C:A_Timeout 2024-08-07T23:09:11.021Z,1723072151.021 [sink:NeedComms:C:A_Timeout:A] Running Loop=1 2024-08-07T23:09:11.026Z,1723072151.026 [sink:NeedComms:C:A_Timeout:A](IMPORTANT): first GPS update timeout 2024-08-07T23:09:11.026Z,1723072151.026 [sink:NeedComms:C:A_Timeout:A] Stopped 2024-08-07T23:09:11.026Z,1723072151.026 [sink:NeedComms:C:A_Timeout](INFO): Completed sink:NeedComms:C:A_Timeout 2024-08-07T23:09:11.026Z,1723072151.026 [sink:NeedComms:C] Stopped 2024-08-07T23:09:11.026Z,1723072151.026 [sink:NeedComms:D] Running Loop=1 2024-08-07T23:09:20.459Z,1723072160.459 [sink](INFO): Timed out from 2024-08-07T23:02:20.2Z 2024-08-07T23:09:20.460Z,1723072160.460 [MissionManager](INFO): sink is completed. 2024-08-07T23:09:20.460Z,1723072160.460 [MissionManager](INFO): Uninitializing Mission sink 2024-08-07T23:09:20.460Z,1723072160.460 [sink] Stopped 2024-08-07T23:09:20.460Z,1723072160.460 [sink](DEBUG): Aggregate::uninitialize sink 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science] Stopped 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science](DEBUG): Aggregate::uninitialize sink:Science 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science:B] Stopped 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science:C] Stopped 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science:E] Stopped 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science:F] Stopped 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science:OceanCurrent] Stopped 2024-08-07T23:09:20.460Z,1723072160.460 [sink:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sink:Science:OceanCurrent 2024-08-07T23:09:20.461Z,1723072160.461 [sink:Science:OceanCurrent:A.] Stopped 2024-08-07T23:09:20.461Z,1723072160.461 [sink:NeedComms] Stopped 2024-08-07T23:09:20.461Z,1723072160.461 [sink:NeedComms](DEBUG): Aggregate::uninitialize sink:NeedComms 2024-08-07T23:09:20.461Z,1723072160.461 [sink:NeedComms:B.GoToSurface] Stopped 2024-08-07T23:09:20.461Z,1723072160.461 [sink:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-07T23:09:20.461Z,1723072160.461 [sink:NeedComms:D] Stopped 2024-08-07T23:09:20.461Z,1723072160.461 [sink:StandardEnvelopes] Stopped 2024-08-07T23:09:20.461Z,1723072160.461 [sink:StandardEnvelopes](DEBUG): Aggregate::uninitialize sink:StandardEnvelopes 2024-08-07T23:09:20.461Z,1723072160.461 [sink:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2024-08-07T23:09:20.461Z,1723072160.461 [sink:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2024-08-07T23:09:20.461Z,1723072160.461 [sink:StandardEnvelopes:B.DepthEnvelope] Stopped 2024-08-07T23:09:20.461Z,1723072160.461 [sink:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2024-08-07T23:09:20.462Z,1723072160.462 [sink:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2024-08-07T23:09:20.462Z,1723072160.462 [sink:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2024-08-07T23:09:20.462Z,1723072160.462 [sink:BackseatDriver] Stopped 2024-08-07T23:09:20.462Z,1723072160.462 [sink:BackseatDriver](DEBUG): Aggregate::uninitialize sink:BackseatDriver 2024-08-07T23:09:20.462Z,1723072160.462 [sink:BackseatDriver:A.BackseatDriver] Stopped 2024-08-07T23:09:20.462Z,1723072160.462 [sink:PowerOnly] Stopped 2024-08-07T23:09:20.462Z,1723072160.462 [sink:PowerOnly](DEBUG): Aggregate::uninitialize sink:PowerOnly 2024-08-07T23:09:20.462Z,1723072160.462 [sink:PowerOnly:E.Wait] Stopped 2024-08-07T23:09:20.462Z,1723072160.462 [sink:PowerOnly:E.Wait](DEBUG): Uninitialize Wait Component. 2024-08-07T23:09:20.462Z,1723072160.462 [sink:RunSink] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink](DEBUG): Aggregate::uninitialize sink:RunSink 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:A] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:B] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:C] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:D] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:E] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth](DEBUG): Aggregate::uninitialize sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Uninitialize. 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait] Stopped 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Uninitialize Wait Component. 2024-08-07T23:09:20.463Z,1723072160.463 [sink:RunSink:JustSink] Stopped 2024-08-07T23:09:20.464Z,1723072160.464 [sink:RunSink:JustSink](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink 2024-08-07T23:09:20.464Z,1723072160.464 [sink:RunSink:JustSink:C] Stopped 2024-08-07T23:09:20.464Z,1723072160.464 [sink:RunSink:JustSink:C](DEBUG): Aggregate::uninitialize sink:RunSink:JustSink:C 2024-08-07T23:09:20.575Z,1723072160.575 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/OnDock.tl 2024-08-07T23:09:20.645Z,1723072160.645 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/OnDock.tl 2024-08-07T23:09:20.645Z,1723072160.645 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/OnDock.tl 2024-08-07T23:09:20.652Z,1723072160.652 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/OnDock.tl 2024-08-07T23:09:20.698Z,1723072160.698 [WetLabsUBAT](INFO): Powering down 2024-08-07T23:09:21.047Z,1723072161.047 [WetLabsBB2FL](INFO): Powering down 2024-08-07T23:09:21.612Z,1723072161.612 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/OnDock.tl translated into: 8 2 1 5 2 30 5 Restarting logs restart logs ! ifconfig Mission ending, breaking off. Range: . 2024-08-07T23:09:21.619Z,1723072161.619 [MissionManager](INFO): DefineArg OnDock.DockedTime = 8.000000 h 2024-08-07T23:09:21.623Z,1723072161.623 [MissionManager](INFO): DefineArg OnDock.DetachedTimeout = 30.000000 s 2024-08-07T23:09:21.628Z,1723072161.628 [MissionManager](INFO): DefineArg OnDock.RangeTimeout = 600.000000 s 2024-08-07T23:09:21.632Z,1723072161.632 [MissionManager](INFO): DefineArg OnDock.TrackingUpdatePeriod = 2.000000 min 2024-08-07T23:09:21.652Z,1723072161.652 [MissionManager](INFO): DefineArg OnDock.NumberOfPings = 1.000000 count 2024-08-07T23:09:21.704Z,1723072161.704 [MissionManager](INFO): DefineArg OnDock.TransponderCode = 50 count 2024-08-07T23:09:21.712Z,1723072161.712 [MissionManager](INFO): DefineArg OnDock.MaxDepth = 215.000000 m 2024-08-07T23:09:21.721Z,1723072161.721 [MissionManager](INFO): DefineArg OnDock.MinAltitude = 5.000000 m 2024-08-07T23:09:21.741Z,1723072161.741 [MissionManager](INFO): DefineArg OnDock.MinOffshore = 2.000000 km 2024-08-07T23:09:21.761Z,1723072161.761 [MissionManager](INFO): DefineArg OnDock.StayOnDock = 0 bool 2024-08-07T23:09:21.780Z,1723072161.780 [MissionManager](INFO): DefineArg OnDock.IfconfigInterval = 30.000000 min 2024-08-07T23:09:21.797Z,1723072161.797 [MissionManager](INFO): DefineArg OnDock.MissionTimeout = 8.000000 h 2024-08-07T23:09:21.797Z,1723072161.797 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.tl 2024-08-07T23:09:21.799Z,1723072161.799 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/StandardEnvelopes.tl 2024-08-07T23:09:21.800Z,1723072161.800 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/StandardEnvelopes.tl 2024-08-07T23:09:21.981Z,1723072161.981 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/StandardEnvelopes.tl translated into: 5 0 200 2000 2024-08-07T23:09:21.997Z,1723072161.997 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinAltitude = 5.000000 m 2024-08-07T23:09:22.009Z,1723072162.009 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepthIgnore = 0.000000 m 2024-08-07T23:09:22.021Z,1723072162.021 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MaxDepth = 200.000000 m 2024-08-07T23:09:22.024Z,1723072162.024 [MissionManager](INFO): DefineArg OnDock:StandardEnvelopes.MinOffshore = 2000.000000 m 2024-08-07T23:09:22.030Z,1723072162.030 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2024-08-07T23:09:22.057Z,1723072162.057 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2024-08-07T23:09:22.150Z,1723072162.150 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2024-08-07T23:09:22.198Z,1723072162.198 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl 2024-08-07T23:09:22.198Z,1723072162.198 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl 2024-08-07T23:09:22.199Z,1723072162.199 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl 2024-08-07T23:09:22.263Z,1723072162.263 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into: 2024-08-07T23:09:22.289Z,1723072162.289 [MissionManager](INFO): DefineArg OnDock:BackseatDriver.EnableBackseat = 0 bool 2024-08-07T23:09:22.297Z,1723072162.297 [OnDock:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver. 2024-08-07T23:09:22.315Z,1723072162.315 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/PowerOnly.tl 2024-08-07T23:09:22.315Z,1723072162.315 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/PowerOnly.tl 2024-08-07T23:09:22.316Z,1723072162.316 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/PowerOnly.tl 2024-08-07T23:09:22.661Z,1723072162.661 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/PowerOnly.tl translated into: 99999 2024-08-07T23:09:22.679Z,1723072162.679 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleAll = 0 bool 2024-08-07T23:09:22.683Z,1723072162.683 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad1 = 0 bool 2024-08-07T23:09:22.691Z,1723072162.691 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad2 = 0 bool 2024-08-07T23:09:22.696Z,1723072162.696 [MissionManager](INFO): DefineArg OnDock:PowerOnly.SampleLoad3 = 0 bool 2024-08-07T23:09:22.735Z,1723072162.735 [MissionManager](INFO): DefineArg OnDock:PowerOnly.EnabledPowerOnly = 0 bool 2024-08-07T23:09:22.776Z,1723072162.776 [OnDock:PowerOnly:E.Wait](DEBUG): Construct Wait. 2024-08-07T23:09:22.995Z,1723072162.995 [OnDock:K.Execute](DEBUG): Construct Execute. 2024-08-07T23:09:23.007Z,1723072163.007 [OnDock:PeriodicCheck:CheckIP:A.Execute](DEBUG): Construct Execute. 2024-08-07T23:09:23.018Z,1723072163.018 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Construct Wait. 2024-08-07T23:09:23.021Z,1723072163.021 [OnDock:M.Docked](DEBUG): Construct. 2024-08-07T23:09:23.021Z,1723072163.021 [OnDock:M.Docked](DEBUG): Initializing internal variables to default values. 2024-08-07T23:09:23.188Z,1723072163.188 [OnDock:Detach:B.Undock](DEBUG): Construct. 2024-08-07T23:09:23.188Z,1723072163.188 [OnDock:Detach:B.Undock](DEBUG): Initializing internal variables to default values. 2024-08-07T23:09:23.295Z,1723072163.295 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission { """ Wait on dock, communicating when possible """ arguments { DockedTime = 8 hour """ Time to stay on dock. Mission timeout will be five minutes longer. """ DetachedTimeout = Dock:Docked.detachTimeout """ Time duration limit for determining if the vehicle is detached from the dock. """ RangeTimeout = Dock:Docked.rangeTimeout """ Maximum allowed time without acoustic range. """ TrackingUpdatePeriod = 2 minute """ How long to wait between acoustic queries. """ NumberOfPings = 1 count """ Number of pings requested each time. """ TransponderCode = Dock:Dock.transponderCode """ Transponder Address. """ MaxDepth = BIT:CBIT.stopDepth """ Maximum depth while docked. """ MinAltitude = 5 meter """ Minimum altitude """ MinOffshore = 2 km """ Minimum offshore """ StayOnDock = false """ If true, don't detach from dock at end of mission """ IfconfigInterval = 30 minute """ How long to wait between ifconfig runs """ # Mission variables (do not change) MissionTimeout = DockedTime """ Mission timeout (local variable, do not change) """ } timeout duration=MissionTimeout insert Insert/StandardEnvelopes.tl assign in sequence StandardEnvelopes:MinAltitude = MinAltitude assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore # End docking 5 minutes before end of mission to allow clean undock assign in sequence MissionTimeout = DockedTime + 5 minute insert Insert/BackseatDriver.tl insert Insert/PowerOnly.tl # Send data when connection exists readData { while ( Sensor:DataOverHttps.connectionStatus == true ) Universal:platform_communications } behavior Estimation:TrackAcousticContact { run in parallel set contactLabelSetting = TransponderCode set numberOfSamplesSetting = NumberOfPings set updatePeriodSetting = TrackingUpdatePeriod } syslog important "Restarting logs" behavior Guidance:Execute { run in sequence set command = "restart logs" } aggregate PeriodicCheck { run in parallel aggregate CheckIP { run in sequence behavior Guidance:Execute { run in sequence set command = "! ifconfig" } behavior Guidance:Wait { run in sequence set duration = IfconfigInterval } } } behavior Dock:Docked { run in sequence timeout duration=DockedTime set detachTimeout = DetachedTimeout set rangeTimeout = RangeTimeout } # Undock cleanly, instead of relying on DefaultWithUndock to come next aggregate Detach { run in sequence break if ( StayOnDock == true ) syslog important "Mission ending, breaking off. Range: " + Estimation:TrackAcousticContact.range_to_contact~meter + "." behavior Dock:Undock { run in sequence } } } 2024-08-07T23:09:23.296Z,1723072163.296 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/OnDock.tl id=OnDock 2024-08-07T23:09:23.397Z,1723072163.397 [MissionManager](IMPORTANT): Started mission Default 2024-08-07T23:09:23.397Z,1723072163.397 [Default] Running Loop=1 2024-08-07T23:09:23.397Z,1723072163.397 [Default](DEBUG): Aggregate::initialize Default 2024-08-07T23:09:23.397Z,1723072163.397 [Default:B.GoToSurface] Running Loop=1 2024-08-07T23:09:23.397Z,1723072163.397 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-08-07T23:09:23.414Z,1723072163.414 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-08-07T23:09:23.414Z,1723072163.414 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-08-07T23:09:23.414Z,1723072163.414 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-08-07T23:09:23.415Z,1723072163.415 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-08-07T23:09:23.415Z,1723072163.415 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-08-07T23:09:23.415Z,1723072163.415 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-08-07T23:09:23.415Z,1723072163.415 [Default:A.Wait] Running Loop=1 2024-08-07T23:09:23.415Z,1723072163.415 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-08-07T23:09:36.709Z,1723072176.709 [Default:A.Wait](INFO): Done Waiting. 2024-08-07T23:09:36.709Z,1723072176.709 [Default:A.Wait] Stopped 2024-08-07T23:09:36.709Z,1723072176.709 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-08-07T23:09:37.103Z,1723072177.103 [Default:CheckIn] Running Loop=1 2024-08-07T23:09:37.103Z,1723072177.103 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-08-07T23:09:37.103Z,1723072177.103 [Default:CheckIn:Read_GPS] Running Loop=1 2024-08-07T23:09:43.978Z,1723072183.978 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240807T225801/Courier0018.lzma 2024-08-07T23:09:44.980Z,1723072184.980 [DataOverHttps](INFO): Moved sent file to Logs/20240807T225801/Courier0018.lzma.bak 2024-08-07T23:09:44.980Z,1723072184.980 [DataOverHttps](INFO): SBD MOMSN=21448307 2024-08-07T23:09:45.982Z,1723072185.982 [DataOverHttps](DEBUG): Managing dock network, ignoring radio surface power off 2024-08-07T23:09:46.574Z,1723072186.574 [CommandExec](IMPORTANT): got command set OnDock.DockedTime 15 minute 2024-08-07T23:09:46.575Z,1723072186.575 [CommandExec](IMPORTANT): got command set OnDock.DetachedTimeout 100 minute 2024-08-07T23:09:46.576Z,1723072186.576 [CommandExec](IMPORTANT): got command set OnDock.RangeTimeout 100 minute 2024-08-07T23:09:46.576Z,1723072186.576 [CommandExec](IMPORTANT): got command set OnDock.TrackingUpdatePeriod 100 minute 2024-08-07T23:09:46.577Z,1723072186.577 [CommandExec](IMPORTANT): got command set OnDock.MinAltitude 0.0001 meter 2024-08-07T23:09:46.578Z,1723072186.578 [CommandExec](IMPORTANT): got command set OnDock.MinOffshore 0.0001 kilometer 2024-08-07T23:09:50.450Z,1723072190.450 [CommandExec](IMPORTANT): got command set OnDock.IfconfigInterval 3 minute 2024-08-07T23:09:50.450Z,1723072190.450 [CommandExec](IMPORTANT): got command run 2024-08-07T23:09:50.452Z,1723072190.452 [CommandExec](IMPORTANT): Running 2024-08-07T23:09:50.840Z,1723072190.840 [Default] Stopped 2024-08-07T23:09:50.840Z,1723072190.840 [Default](DEBUG): Aggregate::uninitialize Default 2024-08-07T23:09:50.841Z,1723072190.841 [Default:B.GoToSurface] Stopped 2024-08-07T23:09:50.841Z,1723072190.841 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-08-07T23:09:50.841Z,1723072190.841 [Default:CheckIn] Stopped 2024-08-07T23:09:50.841Z,1723072190.841 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-08-07T23:09:50.841Z,1723072190.841 [Default:CheckIn:Read_GPS] Stopped 2024-08-07T23:09:50.841Z,1723072190.841 [MissionManager](IMPORTANT): Started mission OnDock 2024-08-07T23:09:50.841Z,1723072190.841 [OnDock] Running Loop=1 2024-08-07T23:09:50.841Z,1723072190.841 [OnDock](DEBUG): Aggregate::initialize OnDock 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes] Running Loop=1 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes](DEBUG): Aggregate::initialize OnDock:StandardEnvelopes 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2024-08-07T23:09:50.846Z,1723072190.846 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:BackseatDriver] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:BackseatDriver](DEBUG): Aggregate::initialize OnDock:BackseatDriver 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:BackseatDriver:A.BackseatDriver] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly](DEBUG): Aggregate::initialize OnDock:PowerOnly 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly:A] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly:B] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly:C] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly:D] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly:E.Wait] Running Loop=1 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:PowerOnly:E.Wait](DEBUG): Initialize Wait Component. 2024-08-07T23:09:50.847Z,1723072190.847 [OnDock:H] Running Loop=1 2024-08-07T23:09:50.848Z,1723072190.848 [OnDock:I.] Running Loop=1 2024-08-07T23:09:50.848Z,1723072190.848 [OnDock:I.](INFO): Initializing TrackAcousticContact. 2024-08-07T23:09:50.848Z,1723072190.848 [OnDock:PeriodicCheck] Running Loop=1 2024-08-07T23:09:50.848Z,1723072190.848 [OnDock:PeriodicCheck](DEBUG): Aggregate::initialize OnDock:PeriodicCheck 2024-08-07T23:09:50.848Z,1723072190.848 [OnDock:PeriodicCheck:CheckIP] Running Loop=1 2024-08-07T23:09:50.848Z,1723072190.848 [OnDock:PeriodicCheck:CheckIP](DEBUG): Aggregate::initialize OnDock:PeriodicCheck:CheckIP 2024-08-07T23:09:50.848Z,1723072190.848 [OnDock:PeriodicCheck:CheckIP:A.Execute] Running Loop=1 2024-08-07T23:09:50.849Z,1723072190.849 [OnDock:B] Running Loop=1 2024-08-07T23:09:50.849Z,1723072190.849 [OnDock:PeriodicCheck] Running Loop=1 2024-08-07T23:09:50.849Z,1723072190.849 [OnDock:PeriodicCheck:CheckIP:A.Execute](INFO): Executing command ! ifconfig 2024-08-07T23:09:50.849Z,1723072190.849 [OnDock:PeriodicCheck:CheckIP:A.Execute] Stopped 2024-08-07T23:09:50.849Z,1723072190.849 [OnDock:PeriodicCheck:CheckIP:B.Wait] Running Loop=1 2024-08-07T23:09:50.867Z,1723072190.867 [CommandExec](IMPORTANT): got command ! ifconfig 2024-08-07T23:09:50.849Z,1723072190.849 [OnDock:PeriodicCheck:CheckIP:B.Wait](DEBUG): Initialize Wait Component. 2024-08-07T23:09:50.902Z,1723072190.902 [OnDock:I.] Running Loop=1 2024-08-07T23:09:50.903Z,1723072190.903 [OnDock:I.](INFO): Received request for long update period 100.000000 minutes, decreasing to 5 minutes. 2024-08-07T23:09:50.904Z,1723072190.904 [OnDock:H] Running Loop=1 2024-08-07T23:09:50.904Z,1723072190.904 [OnDock:H](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-08-07T23:09:50.905Z,1723072190.905 [OnDock:PowerOnly] Running Loop=1 2024-08-07T23:09:50.905Z,1723072190.905 [OnDock:PowerOnly:D] Stopped 2024-08-07T23:09:50.905Z,1723072190.905 [OnDock:PowerOnly:C] Stopped 2024-08-07T23:09:50.905Z,1723072190.905 [OnDock:PowerOnly:B] Stopped 2024-08-07T23:09:50.918Z,1723072190.918 [OnDock:PowerOnly:A] Stopped 2024-08-07T23:09:50.919Z,1723072190.919 [OnDock:BackseatDriver] Running Loop=1 2024-08-07T23:09:50.919Z,1723072190.919 [OnDock:B] Stopped 2024-08-07T23:09:50.920Z,1723072190.920 [OnDock:C] Running Loop=1 2024-08-07T23:09:50.920Z,1723072190.920 [OnDock:StandardEnvelopes] Running Loop=1 2024-08-07T23:09:50.920Z,1723072190.920 [OnDock:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2024-08-07T23:09:50.920Z,1723072190.920 [OnDock:StandardEnvelopes:C.OffshoreEnvelope](IMPORTANT): Offshore envelope ACTIVE 2024-08-07T23:09:50.952Z,1723072190.952 [OnDock:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2024-08-07T23:09:50.953Z,1723072190.953 [OnDock:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2024-08-07T23:09:51.130Z,1723072191.130 [CommandExec](IMPORTANT): eth0 Link encap:Ethernet HWaddr 50:2D:F4:07:45:4B inet addr:10.89.10.2 Bcast:10.89.255.255 Mask:255.255.0.0 UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:5762 errors:0 dropped:0 overruns:0 frame:0 TX packets:7351 errors:0 dropped:0 overruns:0 carrier:0 collisions:30 txqueuelen:1000 RX bytes:1748542 (1.6 Mb) TX bytes:4071670 (3.8 Mb) Interrupt:29 lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 UP LOOPBACK RUNNING MULTICAST MTU:16436 Metric:1 RX packets:364 errors:0 dropped:0 overruns:0 frame:0 TX packets:364 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:0 RX bytes:27185 (26.5 Kb) TX bytes:27185 (26.5 Kb) 2024-08-07T23:09:51.942Z,1723072191.942 [OnDock:I.](INFO): Received request for long update period 100.000000 minutes, decreasing to 5 minutes. 2024-08-07T23:09:51.943Z,1723072191.943 [OnDock:C] Stopped 2024-08-07T23:09:51.943Z,1723072191.943 [OnDock:D] Running Loop=1 2024-08-07T23:09:52.299Z,1723072192.299 [OnDock:I.](INFO): Received request for long update period 100.000000 minutes, decreasing to 5 minutes. 2024-08-07T23:09:52.305Z,1723072192.305 [OnDock:D] Stopped 2024-08-07T23:09:52.305Z,1723072192.305 [OnDock:E] Running Loop=1 2024-08-07T23:09:52.719Z,1723072192.719 [OnDock:I.](INFO): Received request for long update period 100.000000 minutes, decreasing to 5 minutes. 2024-08-07T23:09:52.720Z,1723072192.720 [OnDock:E] Stopped 2024-08-07T23:09:52.720Z,1723072192.720 [OnDock:J] Running Loop=1 2024-08-07T23:09:53.081Z,1723072193.081 [OnDock:J](IMPORTANT): Restarting logs 2024-08-07T23:09:53.081Z,1723072193.081 [OnDock:J] Stopped 2024-08-07T23:09:53.081Z,1723072193.081 [OnDock:K.Execute] Running Loop=1 2024-08-07T23:09:53.086Z,1723072193.086 [OnDock:I.](INFO): Received request for long update period 100.000000 minutes, decreasing to 5 minutes.