2022-10-19T17:39:51.716Z,1666201191.716 [CommandExec](IMPORTANT): got command restart logs 2022-10-19T17:40:00.935Z,1666201200.935 [NAL9602](INFO): SBD MO Status=1, MOMSN=21683, MT Status=0, MTMSN=0 2022-10-19T17:40:00.987Z,1666201200.987 [NAL9602](INFO): Sent 39 bytes from file Logs/20221018T171603/Courier0162.lzma 2022-10-19T17:40:00.987Z,1666201200.987 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:40:01.491Z,1666201201.491 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:40:14.348Z,1666201214.348 [NAL9602](INFO): SBD MO Status=1, MOMSN=21684, MT Status=0, MTMSN=0 2022-10-19T17:40:14.400Z,1666201214.400 [NAL9602](INFO): Sent 117 bytes from file Logs/20221018T171603/Express0163.lzma 2022-10-19T17:40:14.400Z,1666201214.400 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:40:25.686Z,1666201225.686 [NAL9602](INFO): SBD MO Status=0, MOMSN=21685, MT Status=0, MTMSN=0 2022-10-19T17:40:36.631Z,1666201236.631 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:40:43.110Z,1666201243.110 [NAL9602](INFO): SBD MO Status=1, MOMSN=21686, MT Status=0, MTMSN=0 2022-10-19T17:40:43.167Z,1666201243.167 [NAL9602](INFO): Sent 151 bytes from file Logs/20221019T173951/Courier0000.lzma 2022-10-19T17:40:43.167Z,1666201243.167 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:40:53.710Z,1666201253.710 [NAL9602](INFO): SBD MO Status=1, MOMSN=21687, MT Status=0, MTMSN=0 2022-10-19T17:40:53.759Z,1666201253.759 [NAL9602](INFO): Sent 311 bytes from file Logs/20221019T173951/Express0001.lzma 2022-10-19T17:40:53.759Z,1666201253.759 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:41:05.425Z,1666201265.425 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=21688, MT Status=1, MTMSN=1159 2022-10-19T17:41:06.152Z,1666201266.152 [NAL9602](INFO): Received command: load Science/sci2.tl;set sci2.MissionTimeout 8 h;set sci2.Lat1 36.32285 degree;set sci2.Lon1 -121.943979 degree;set sci2.Lat2 36.402559 degree;set sci2.Lon2 -122.240232 degree;set sci2.YoYoMaxDepth 35 m;set sci2.MaxDepth 50 m;run 2022-10-19T17:41:06.261Z,1666201266.261 [CommandExec](IMPORTANT): got command load ./Missions/Science/sci2.tl 2022-10-19T17:41:06.262Z,1666201266.262 [MissionManager](INFO): Loading Mission from file: ./Missions/Science/sci2.tl 2022-10-19T17:41:06.262Z,1666201266.262 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file ./Missions/Science/sci2.tx 2022-10-19T17:41:06.449Z,1666201266.449 [MissionManager](INFO): DefineArg sci2.MissionTimeout = 2.000000 h 2022-10-19T17:41:06.461Z,1666201266.461 [MissionManager](INFO): DefineArg sci2.NeedCommsTime = 60.000000 min 2022-10-19T17:41:06.462Z,1666201266.462 [MissionManager](INFO): DefineArg sci2.Repeat = 1.000000 count 2022-10-19T17:41:06.465Z,1666201266.465 [MissionManager](INFO): DefineArg sci2.Lat1 = nan arcdeg 2022-10-19T17:41:06.467Z,1666201266.467 [MissionManager](INFO): DefineArg sci2.Lon1 = nan arcdeg 2022-10-19T17:41:06.469Z,1666201266.469 [MissionManager](INFO): DefineArg sci2.Lat2 = nan arcdeg 2022-10-19T17:41:06.471Z,1666201266.471 [MissionManager](INFO): DefineArg sci2.Lon2 = nan arcdeg 2022-10-19T17:41:06.473Z,1666201266.473 [MissionManager](INFO): DefineArg sci2.Lat3 = nan arcdeg 2022-10-19T17:41:06.474Z,1666201266.474 [MissionManager](INFO): DefineArg sci2.Lon3 = nan arcdeg 2022-10-19T17:41:06.477Z,1666201266.477 [MissionManager](INFO): DefineArg sci2.Lat4 = nan arcdeg 2022-10-19T17:41:06.478Z,1666201266.478 [MissionManager](INFO): DefineArg sci2.Lon4 = nan arcdeg 2022-10-19T17:41:06.481Z,1666201266.481 [MissionManager](INFO): DefineArg sci2.Lat5 = nan arcdeg 2022-10-19T17:41:06.482Z,1666201266.482 [MissionManager](INFO): DefineArg sci2.Lon5 = nan arcdeg 2022-10-19T17:41:06.485Z,1666201266.485 [MissionManager](INFO): DefineArg sci2.Lat6 = nan arcdeg 2022-10-19T17:41:06.486Z,1666201266.486 [MissionManager](INFO): DefineArg sci2.Lon6 = nan arcdeg 2022-10-19T17:41:06.488Z,1666201266.488 [MissionManager](INFO): DefineArg sci2.Lat7 = nan arcdeg 2022-10-19T17:41:06.490Z,1666201266.490 [MissionManager](INFO): DefineArg sci2.Lon7 = nan arcdeg 2022-10-19T17:41:06.493Z,1666201266.493 [MissionManager](INFO): DefineArg sci2.Speed = 1.000000 m/s 2022-10-19T17:41:06.494Z,1666201266.494 [MissionManager](INFO): DefineArg sci2.CaptureRadius = nan m 2022-10-19T17:41:06.497Z,1666201266.497 [MissionManager](INFO): DefineArg sci2.YoYoMinDepth = 2.000000 m 2022-10-19T17:41:06.499Z,1666201266.499 [MissionManager](INFO): DefineArg sci2.YoYoMaxDepth = 200.000000 m 2022-10-19T17:41:06.501Z,1666201266.501 [MissionManager](INFO): DefineArg sci2.YoYoMinAltitude = 9.000000 m 2022-10-19T17:41:06.523Z,1666201266.523 [MissionManager](INFO): DefineArg sci2.YoYoUpPitch = 20.000000 arcdeg 2022-10-19T17:41:06.525Z,1666201266.525 [MissionManager](INFO): DefineArg sci2.YoYoDownPitch = -20.000000 arcdeg 2022-10-19T17:41:06.532Z,1666201266.532 [MissionManager](INFO): DefineArg sci2.BuoyancyNeutral = 220.217773 cc 2022-10-19T17:41:06.534Z,1666201266.534 [MissionManager](INFO): DefineArg sci2.MassDefault = 0.683467 cm 2022-10-19T17:41:06.541Z,1666201266.541 [MissionManager](INFO): DefineArg sci2.MinAltitude = 5.000000 m 2022-10-19T17:41:06.547Z,1666201266.547 [MissionManager](INFO): DefineArg sci2.MaxDepth = 205.000000 m 2022-10-19T17:41:06.549Z,1666201266.549 [MissionManager](INFO): DefineArg sci2.MinOffshore = 2.000000 km 2022-10-19T17:41:06.550Z,1666201266.550 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml 2022-10-19T17:41:06.977Z,1666201266.977 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectChlActive = 0 bool 2022-10-19T17:41:06.980Z,1666201266.980 [MissionManager](INFO): DefineArg sci2:Science.TimeWindowPeakReport = nan min 2022-10-19T17:41:06.981Z,1666201266.981 [MissionManager](INFO): DefineArg sci2:Science.HighestChlPeakReportActive = 0 bool 2022-10-19T17:41:07.002Z,1666201267.002 [MissionManager](INFO): DefineArg sci2:Science.HighestSaltPeakReportActive = 0 bool 2022-10-19T17:41:07.004Z,1666201267.004 [MissionManager](INFO): DefineArg sci2:Science.HighestOilPeakReportActive = 0 bool 2022-10-19T17:41:07.006Z,1666201267.006 [MissionManager](INFO): DefineArg sci2:Science.PatchTracking = 0 bool 2022-10-19T17:41:07.008Z,1666201267.008 [MissionManager](INFO): DefineArg sci2:Science.DetectTrough = 0 bool 2022-10-19T17:41:07.010Z,1666201267.010 [MissionManager](INFO): DefineArg sci2:Science.FilterWidthHorizontal = 3.000000 count 2022-10-19T17:41:07.012Z,1666201267.012 [MissionManager](INFO): DefineArg sci2:Science.NumProfilesSlidingwindow = 100.000000 count 2022-10-19T17:41:07.014Z,1666201267.014 [MissionManager](INFO): DefineArg sci2:Science.OffPeakFractionHorizontal = 80.000000 % 2022-10-19T17:41:07.016Z,1666201267.016 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectNO3Active = 0 bool 2022-10-19T17:41:07.018Z,1666201267.018 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectOilActive = 0 bool 2022-10-19T17:41:07.020Z,1666201267.020 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectFDOMActive = 0 bool 2022-10-19T17:41:07.022Z,1666201267.022 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectSalinityActive = 0 bool 2022-10-19T17:41:07.052Z,1666201267.052 [MissionManager](INFO): DefineArg sci2:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2022-10-19T17:41:07.054Z,1666201267.054 [MissionManager](INFO): DefineArg sci2:Science.EnabledAanderaaO2 = 0 bool 2022-10-19T17:41:07.061Z,1666201267.061 [MissionManager](INFO): DefineArg sci2:Science.EnabledNeilBrown = 0 bool 2022-10-19T17:41:07.069Z,1666201267.069 [MissionManager](INFO): DefineArg sci2:Science.EnabledSeabird = 1 bool 2022-10-19T17:41:07.080Z,1666201267.080 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsBB2FL = 1 bool 2022-10-19T17:41:07.083Z,1666201267.083 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2022-10-19T17:41:07.089Z,1666201267.089 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsUBAT = 1 bool 2022-10-19T17:41:07.104Z,1666201267.104 [MissionManager](INFO): DefineArg sci2:Science.LowPassWindowLength = 20.000000 count 2022-10-19T17:41:07.106Z,1666201267.106 [MissionManager](INFO): DefineArg sci2:Science.MedianFilterLen = 5.000000 count 2022-10-19T17:41:07.124Z,1666201267.124 [MissionManager](INFO): DefineArg sci2:Science.PeakShallowBound = nan m 2022-10-19T17:41:07.126Z,1666201267.126 [MissionManager](INFO): DefineArg sci2:Science.PeakDeepBound = nan m 2022-10-19T17:41:07.136Z,1666201267.136 [MissionManager](INFO): DefineArg sci2:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2022-10-19T17:41:07.138Z,1666201267.138 [MissionManager](INFO): DefineOutput sci2:Science.PeakChl = 0.000000 ug/l 2022-10-19T17:41:07.145Z,1666201267.145 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlDepth = 0.000000 m 2022-10-19T17:41:07.167Z,1666201267.167 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlTemperature = 0.000000 degC 2022-10-19T17:41:07.169Z,1666201267.169 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlLatitude = nan arcdeg 2022-10-19T17:41:07.176Z,1666201267.176 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlLongitude = nan arcdeg 2022-10-19T17:41:07.178Z,1666201267.178 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3 = 0.000000 umol/l 2022-10-19T17:41:07.189Z,1666201267.189 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Depth = 0.000000 m 2022-10-19T17:41:07.195Z,1666201267.195 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Latitude = nan arcdeg 2022-10-19T17:41:07.197Z,1666201267.197 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Longitude = nan arcdeg 2022-10-19T17:41:07.200Z,1666201267.200 [MissionManager](INFO): DefineOutput sci2:Science.PeakOil = 0.000000 kg/m3 2022-10-19T17:41:07.202Z,1666201267.202 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilDepth = 0.000000 m 2022-10-19T17:41:07.216Z,1666201267.216 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilLatitude = nan arcdeg 2022-10-19T17:41:07.218Z,1666201267.218 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilLongitude = nan arcdeg 2022-10-19T17:41:07.233Z,1666201267.233 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOM = 0.000000 ppb 2022-10-19T17:41:07.242Z,1666201267.242 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMDepth = 0.000000 m 2022-10-19T17:41:07.249Z,1666201267.249 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMTemperature = nan degC 2022-10-19T17:41:07.259Z,1666201267.259 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMLatitude = nan arcdeg 2022-10-19T17:41:07.264Z,1666201267.264 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMLongitude = nan arcdeg 2022-10-19T17:41:07.266Z,1666201267.266 [MissionManager](INFO): DefineOutput sci2:Science.PatchFDOMDistance = nan m 2022-10-19T17:41:07.269Z,1666201267.269 [MissionManager](INFO): DefineOutput sci2:Science.PeakSalt = 0.000000 psu 2022-10-19T17:41:07.275Z,1666201267.275 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltDepth = 0.000000 m 2022-10-19T17:41:07.277Z,1666201267.277 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltTemperature = 0.000000 degC 2022-10-19T17:41:07.280Z,1666201267.280 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltLatitude = nan arcdeg 2022-10-19T17:41:07.282Z,1666201267.282 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltLongitude = nan arcdeg 2022-10-19T17:41:07.296Z,1666201267.296 [MissionManager](INFO): DefineOutput sci2:Science.PatchChl = 0.000000 ug/l 2022-10-19T17:41:07.298Z,1666201267.298 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlDepth = 0.000000 m 2022-10-19T17:41:07.305Z,1666201267.305 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlLatitude = nan arcdeg 2022-10-19T17:41:07.311Z,1666201267.311 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlLongitude = nan arcdeg 2022-10-19T17:41:07.313Z,1666201267.313 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlDistance = nan m 2022-10-19T17:41:07.316Z,1666201267.316 [MissionManager](INFO): DefineOutput sci2:Science.PatchSalt = 0.000000 psu 2022-10-19T17:41:07.318Z,1666201267.318 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltDepth = 0.000000 m 2022-10-19T17:41:07.320Z,1666201267.320 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltLatitude = nan arcdeg 2022-10-19T17:41:07.322Z,1666201267.322 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltLongitude = nan arcdeg 2022-10-19T17:41:07.341Z,1666201267.341 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltDistance = nan m 2022-10-19T17:41:07.343Z,1666201267.343 [MissionManager](INFO): DefineOutput sci2:Science.PatchOil = 0.000000 psu 2022-10-19T17:41:07.345Z,1666201267.345 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilDepth = 0.000000 m 2022-10-19T17:41:07.355Z,1666201267.355 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilLatitude = nan arcdeg 2022-10-19T17:41:07.357Z,1666201267.357 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilLongitude = nan arcdeg 2022-10-19T17:41:07.360Z,1666201267.360 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilDistance = nan m 2022-10-19T17:41:07.387Z,1666201267.387 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2022-10-19T17:41:07.418Z,1666201267.418 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2022-10-19T17:41:07.469Z,1666201267.469 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2022-10-19T17:41:07.498Z,1666201267.498 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2022-10-19T17:41:07.533Z,1666201267.533 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2022-10-19T17:41:07.556Z,1666201267.556 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2022-10-19T17:41:07.591Z,1666201267.591 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2022-10-19T17:41:07.624Z,1666201267.624 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2022-10-19T17:41:07.662Z,1666201267.662 [MissionManager](INFO): RedefineArg sci2:Science.PeakDetectChlActive = value:1 bool 2022-10-19T17:41:07.662Z,1666201267.662 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml 2022-10-19T17:41:07.753Z,1666201267.753 [MissionManager](INFO): DefineArg sci2:NeedComms.DiveInterval = 3.000000 h 2022-10-19T17:41:07.759Z,1666201267.759 [MissionManager](INFO): DefineArg sci2:NeedComms.WaitForPitchUp = 10.000000 min 2022-10-19T17:41:07.761Z,1666201267.761 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfacePitch = 20.000000 arcdeg 2022-10-19T17:41:07.767Z,1666201267.767 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfaceDepthRate = nan m/s 2022-10-19T17:41:07.769Z,1666201267.769 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfaceSpeed = 1.000000 m/s 2022-10-19T17:41:07.776Z,1666201267.776 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfacingTimeout = 1000.000000 s 2022-10-19T17:41:07.778Z,1666201267.778 [MissionManager](INFO): DefineArg sci2:NeedComms.GPSTimeout = 7.000000 min 2022-10-19T17:41:07.784Z,1666201267.784 [MissionManager](INFO): DefineArg sci2:NeedComms.CommsTimeout = 30.000000 min 2022-10-19T17:41:07.793Z,1666201267.793 [sci2:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2022-10-19T17:41:07.818Z,1666201267.818 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml 2022-10-19T17:41:07.908Z,1666201267.908 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MinAltitude = 5.000000 m 2022-10-19T17:41:07.910Z,1666201267.910 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MaxDepth = 200.000000 m 2022-10-19T17:41:07.914Z,1666201267.914 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MinOffshore = 2000.000000 m 2022-10-19T17:41:07.931Z,1666201267.931 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2022-10-19T17:41:07.962Z,1666201267.962 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2022-10-19T17:41:08.004Z,1666201268.004 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2022-10-19T17:41:08.030Z,1666201268.030 [sci2:I.Pitch](DEBUG): Construct. 2022-10-19T17:41:08.044Z,1666201268.044 [sci2:J.Buoyancy](DEBUG): Construct Buoyancy. 2022-10-19T17:41:08.046Z,1666201268.046 [sci2:K.SetSpeed](DEBUG): Construct. 2022-10-19T17:41:08.048Z,1666201268.048 [sci2:L.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2022-10-19T17:41:08.068Z,1666201268.068 [sci2:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2022-10-19T17:41:08.075Z,1666201268.075 [sci2:N.YoYo](DEBUG): Construct YoYo. 2022-10-19T17:41:08.082Z,1666201268.082 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Construct Waypoint. 2022-10-19T17:41:08.108Z,1666201268.108 [sci2:Lap:Wpt2:A.Waypoint](DEBUG): Construct Waypoint. 2022-10-19T17:41:08.117Z,1666201268.117 [sci2:Lap:Wpt3:A.Waypoint](DEBUG): Construct Waypoint. 2022-10-19T17:41:08.126Z,1666201268.126 [sci2:Lap:Wpt4:A.Waypoint](DEBUG): Construct Waypoint. 2022-10-19T17:41:08.140Z,1666201268.140 [sci2:Lap:Wpt5:A.Waypoint](DEBUG): Construct Waypoint. 2022-10-19T17:41:08.149Z,1666201268.149 [sci2:Lap:Wpt6:A.Waypoint](DEBUG): Construct Waypoint. 2022-10-19T17:41:08.158Z,1666201268.158 [sci2:Lap:Wpt7:A.Waypoint](DEBUG): Construct Waypoint. 2022-10-19T17:41:08.190Z,1666201268.190 [MissionManager](DEBUG): #! TethysL version initially based on automated translation from original Science/sci2.xml #! and then (syntactically) simplified with use of array/macro extensions in TethysL. mission sci2 { """ Vehicle yo-yo's to the specified waypoints, with science turned on. """ arguments { MissionTimeout = 2 hour """ Maximum duration of mission """ NeedCommsTime = 60 minute """ How often to surface for communications """ Repeat = 1 count """ Number of times the vehicle should try to cycle through waypoints.. """ Lat[1..7] = NaN degree """ Latitude of waypoint {$}. If nan, waypoint is skipped. """ Lon[1..7] = NaN degree """ Longitude of waypoint {$}. If nan, waypoint is skipped. """ Speed = 1 meter_per_second """ Speed while performing the YoYo behavior. """ CaptureRadius = NaN meter """ Speed while performing the YoYo behavior. """ YoYoMinDepth = 2 meter """ Minimum depth while performing the YoYo behavior. """ YoYoMaxDepth = 200 meter """ Maximum depth while performing the YoYo behavior. """ YoYoMinAltitude = 9 meter """ Minimum altitude while performing the YoYo behavior (for bottom-terminated YoYos). """ YoYoUpPitch = 20 degree """ Vehicle up pitch while performing the YoYo behavior. """ YoYoDownPitch = -20 degree """ Vehicle down pitch while performing the YoYo behavior. """ BuoyancyNeutral = Control:VerticalControl.buoyancyNeutral """ Buoyancy bladder position while performing the YoYo behavior. Defaults to buoyancyNeutral setting in the Config/Control.cfg file. Set to NaN cc for active buoyancy """ MassDefault = Control:VerticalControl.massDefault """ Static setting for mass during the mission. Set to NaN mm for active mass position """ MinAltitude = 5 meter """ Minimum height above the sea floor for the entire mission. """ MaxDepth = 205 meter """ Maximum depth for the entire mission. """ MinOffshore = 2 kilometer """ Minimum offshore distance for the entire mission. """ } timeout duration=MissionTimeout insert Insert/Science.xml { """ Most missions will run the science sensors. If you don't place this aggregate above NeedComms, science instruments get turned off on the last upcast and while floating on the surface. """ redefineArg PeakDetectChlActive = true } insert id="NeedComms" Insert/NeedComms.xml assign in sequence NeedComms:DiveInterval = NeedCommsTime insert Insert/StandardEnvelopes.xml assign in sequence StandardEnvelopes:MinAltitude = MinAltitude assign in sequence StandardEnvelopes:MaxDepth = MaxDepth assign in sequence StandardEnvelopes:MinOffshore = MinOffshore call id="StartingMission" refId="NeedComms" behavior Guidance:Pitch { run in parallel set massPosition = MassDefault } behavior Guidance:Buoyancy { run in parallel set position = BuoyancyNeutral } behavior Guidance:SetSpeed { run in parallel set speed = Speed } behavior Guidance:DepthEnvelope { """ Another depth envelope for the YoYo behavior. This envelope should fall within the limits of the standard safety envelopes in Insert/StandardEnvelopes.xml in order to avoid commanding high pitch angles for depth-terminated YoYos. """ run in parallel set minDepth = YoYoMinDepth set maxDepth = YoYoMaxDepth set downPitch = YoYoDownPitch set upPitch = YoYoUpPitch } behavior Guidance:AltitudeEnvelope { """ Another altitude envelope for the YoYo behavior. This envelope should fall within the limits of the standard safety envelopes in Insert/StandardEnvelopes.xml in order to avoid commanding high pitch angles for bottom-terminated YoYos. """ run in parallel set minAltitude = YoYoMinAltitude set upPitch = YoYoUpPitch } behavior Guidance:YoYo { run in parallel set downPitch = YoYoDownPitch set upPitch = YoYoUpPitch } aggregate Lap { run in sequence repeat=Repeat aggregate Wpt1 { run in sequence behavior Guidance:Waypoint { run in sequence set latitude = Lat[1] set longitude = Lon[1] set captureRadius = CaptureRadius } } macro $i = 2..7 { aggregate Wpt$i { run in sequence behavior Guidance:Waypoint { run in sequence set latitude = Lat[$i] set longitude = Lon[$i] } } } } } 2022-10-19T17:41:08.190Z,1666201268.190 [CommandExec](IMPORTANT): Loaded ./Missions/Science/sci2.tl 2022-10-19T17:41:11.771Z,1666201271.771 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:41:16.157Z,1666201276.157 [CommandExec](IMPORTANT): got command set sci2.MissionTimeout 8 hour 2022-10-19T17:41:16.158Z,1666201276.158 [CommandExec](IMPORTANT): got command set sci2.Lat1 36.32285 degree 2022-10-19T17:41:16.159Z,1666201276.159 [CommandExec](IMPORTANT): got command set sci2.Lon1 -121.943979 degree 2022-10-19T17:41:16.160Z,1666201276.160 [CommandExec](IMPORTANT): got command set sci2.Lat2 36.402559 degree 2022-10-19T17:41:16.161Z,1666201276.161 [CommandExec](IMPORTANT): got command set sci2.Lon2 -122.240232 degree 2022-10-19T17:41:16.161Z,1666201276.161 [CommandExec](IMPORTANT): got command set sci2.YoYoMaxDepth 35 meter 2022-10-19T17:41:16.162Z,1666201276.162 [CommandExec](IMPORTANT): got command set sci2.MaxDepth 50 meter 2022-10-19T17:41:16.162Z,1666201276.162 [CommandExec](IMPORTANT): got command run 2022-10-19T17:41:16.188Z,1666201276.188 [CommandExec](IMPORTANT): Running 2022-10-19T17:41:16.407Z,1666201276.407 [Default] Stopped 2022-10-19T17:41:16.408Z,1666201276.408 [Default](DEBUG): Aggregate::uninitialize Default 2022-10-19T17:41:16.408Z,1666201276.408 [Default:B.GoToSurface] Stopped 2022-10-19T17:41:16.408Z,1666201276.408 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-19T17:41:16.408Z,1666201276.408 [Default:CheckIn] Stopped 2022-10-19T17:41:16.408Z,1666201276.408 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2022-10-19T17:41:16.408Z,1666201276.408 [Default:CheckIn:Read_Iridium] Stopped 2022-10-19T17:41:16.408Z,1666201276.408 [MissionManager](IMPORTANT): Started mission sci2 2022-10-19T17:41:16.408Z,1666201276.408 [sci2] Running Loop=1 2022-10-19T17:41:16.408Z,1666201276.408 [sci2](DEBUG): Aggregate::initialize sci2 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science](DEBUG): Aggregate::initialize sci2:Science 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:A] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:B] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:C] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:D] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:E] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:F] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:Read_Oil] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:PeakDetectChl] Running Loop=1 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:PeakDetectChl](DEBUG): Aggregate::initialize sci2:Science:PeakDetectChl 2022-10-19T17:41:16.409Z,1666201276.409 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2022-10-19T17:41:16.410Z,1666201276.410 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2022-10-19T17:41:16.411Z,1666201276.411 [sci2:Science:HighestChlPeakReport] Running Loop=1 2022-10-19T17:41:16.411Z,1666201276.411 [sci2:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sci2:Science:HighestChlPeakReport 2022-10-19T17:41:16.411Z,1666201276.411 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2022-10-19T17:41:16.411Z,1666201276.411 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2022-10-19T17:41:16.412Z,1666201276.412 [sci2:Science:PeakDetectNO3] Running Loop=1 2022-10-19T17:41:16.412Z,1666201276.412 [sci2:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sci2:Science:PeakDetectNO3 2022-10-19T17:41:16.412Z,1666201276.412 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2022-10-19T17:41:16.412Z,1666201276.412 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2022-10-19T17:41:16.413Z,1666201276.413 [sci2:Science:PeakDetectOil] Running Loop=1 2022-10-19T17:41:16.413Z,1666201276.413 [sci2:Science:PeakDetectOil](DEBUG): Aggregate::initialize sci2:Science:PeakDetectOil 2022-10-19T17:41:16.413Z,1666201276.413 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2022-10-19T17:41:16.413Z,1666201276.413 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2022-10-19T17:41:16.414Z,1666201276.414 [sci2:Science:HighestOilPeakReport] Running Loop=1 2022-10-19T17:41:16.415Z,1666201276.415 [sci2:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize sci2:Science:HighestOilPeakReport 2022-10-19T17:41:16.415Z,1666201276.415 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2022-10-19T17:41:16.415Z,1666201276.415 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2022-10-19T17:41:16.415Z,1666201276.415 [sci2:Science:PeakDetectFDOM] Running Loop=1 2022-10-19T17:41:16.415Z,1666201276.415 [sci2:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sci2:Science:PeakDetectFDOM 2022-10-19T17:41:16.416Z,1666201276.416 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2022-10-19T17:41:16.416Z,1666201276.416 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2022-10-19T17:41:16.417Z,1666201276.417 [sci2:Science:PeakDetectSalinity] Running Loop=1 2022-10-19T17:41:16.417Z,1666201276.417 [sci2:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize sci2:Science:PeakDetectSalinity 2022-10-19T17:41:16.417Z,1666201276.417 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2022-10-19T17:41:16.417Z,1666201276.417 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2022-10-19T17:41:16.418Z,1666201276.418 [sci2:Science:HighestSaltPeakReport] Running Loop=1 2022-10-19T17:41:16.418Z,1666201276.418 [sci2:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize sci2:Science:HighestSaltPeakReport 2022-10-19T17:41:16.418Z,1666201276.418 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2022-10-19T17:41:16.419Z,1666201276.419 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2022-10-19T17:41:16.420Z,1666201276.420 [sci2:Science:OceanCurrent] Running Loop=1 2022-10-19T17:41:16.420Z,1666201276.420 [sci2:Science:OceanCurrent](DEBUG): Aggregate::initialize sci2:Science:OceanCurrent 2022-10-19T17:41:16.420Z,1666201276.420 [sci2:Science:OceanCurrent:A.] Running Loop=1 2022-10-19T17:41:16.420Z,1666201276.420 [sci2:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2022-10-19T17:41:16.420Z,1666201276.420 [sci2:StandardEnvelopes] Running Loop=1 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:StandardEnvelopes](DEBUG): Aggregate::initialize sci2:StandardEnvelopes 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:I.Pitch] Running Loop=1 2022-10-19T17:41:16.421Z,1666201276.421 [sci2:I.Pitch](DEBUG): Initialize. 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:J.Buoyancy] Running Loop=1 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:J.Buoyancy](DEBUG): Initialize Buoyancy Component. 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:K.SetSpeed] Running Loop=1 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:K.SetSpeed](DEBUG): Initialize. 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:L.DepthEnvelope] Running Loop=1 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:M.AltitudeEnvelope] Running Loop=1 2022-10-19T17:41:16.422Z,1666201276.422 [sci2:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2022-10-19T17:41:16.423Z,1666201276.423 [sci2:N.YoYo] Running Loop=1 2022-10-19T17:41:16.423Z,1666201276.423 [sci2:N.YoYo](DEBUG): Initialize YoYoComponent. 2022-10-19T17:41:16.423Z,1666201276.423 [sci2:C] Running Loop=1 2022-10-19T17:41:16.424Z,1666201276.424 [sci2:N.YoYo] Running Loop=1 2022-10-19T17:41:16.424Z,1666201276.424 [sci2:M.AltitudeEnvelope] Running Loop=1 2022-10-19T17:41:16.424Z,1666201276.424 [sci2:L.DepthEnvelope] Running Loop=1 2022-10-19T17:41:16.425Z,1666201276.425 [sci2:K.SetSpeed] Running Loop=1 2022-10-19T17:41:16.425Z,1666201276.425 [sci2:J.Buoyancy] Running Loop=1 2022-10-19T17:41:16.426Z,1666201276.426 [sci2:I.Pitch] Running Loop=1 2022-10-19T17:41:16.426Z,1666201276.426 [sci2:StandardEnvelopes] Running Loop=1 2022-10-19T17:41:16.426Z,1666201276.426 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2022-10-19T17:41:16.426Z,1666201276.426 [sci2:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2022-10-19T17:41:16.426Z,1666201276.426 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2022-10-19T17:41:16.447Z,1666201276.447 [sci2:C] Stopped 2022-10-19T17:41:16.447Z,1666201276.447 [sci2:E] Running Loop=1 2022-10-19T17:41:16.447Z,1666201276.447 [sci2:Science] Running Loop=1 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:HighestSaltPeakReport] Stopped 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize sci2:Science:HighestSaltPeakReport 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectSalinity] Stopped 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectSalinity 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectFDOM] Stopped 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectFDOM 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2022-10-19T17:41:16.449Z,1666201276.449 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:HighestOilPeakReport] Stopped 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize sci2:Science:HighestOilPeakReport 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectOil] Stopped 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectOil 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectNO3] Stopped 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectNO3 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2022-10-19T17:41:16.450Z,1666201276.450 [sci2:Science:HighestChlPeakReport] Stopped 2022-10-19T17:41:16.451Z,1666201276.451 [sci2:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sci2:Science:HighestChlPeakReport 2022-10-19T17:41:16.451Z,1666201276.451 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2022-10-19T17:41:16.455Z,1666201276.455 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2022-10-19T17:41:16.455Z,1666201276.455 [sci2:Science:PeakDetectChl] Running Loop=1 2022-10-19T17:41:16.455Z,1666201276.455 [sci2:Science:OceanCurrent:A.] Running Loop=1 2022-10-19T17:41:16.456Z,1666201276.456 [sci2:Science:Read_Oil] Stopped 2022-10-19T17:41:16.457Z,1666201276.457 [sci2:Science:F] Running Loop=1 2022-10-19T17:41:16.457Z,1666201276.457 [sci2:Science:F](DEBUG): Initialize ReadDataComponent to sense WetLabsUBAT.average_bioluminescence 2022-10-19T17:41:16.457Z,1666201276.457 [sci2:Science:E] Running Loop=1 2022-10-19T17:41:16.458Z,1666201276.458 [sci2:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2022-10-19T17:41:16.458Z,1666201276.458 [sci2:Science:D] Stopped 2022-10-19T17:41:16.458Z,1666201276.458 [sci2:Science:C] Running Loop=1 2022-10-19T17:41:16.458Z,1666201276.458 [sci2:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2022-10-19T17:41:16.459Z,1666201276.459 [sci2:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2022-10-19T17:41:16.460Z,1666201276.460 [sci2:Science:B] Running Loop=1 2022-10-19T17:41:16.460Z,1666201276.460 [sci2:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2022-10-19T17:41:16.461Z,1666201276.461 [sci2:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2022-10-19T17:41:16.461Z,1666201276.461 [sci2:Science:A] Stopped 2022-10-19T17:41:16.536Z,1666201276.536 [WetLabsBB2FL](INFO): Powering up 2022-10-19T17:41:16.766Z,1666201276.766 [sci2:E] Stopped 2022-10-19T17:41:16.766Z,1666201276.766 [sci2:F] Running Loop=1 2022-10-19T17:41:17.158Z,1666201277.158 [sci2:F] Stopped 2022-10-19T17:41:17.158Z,1666201277.158 [sci2:G] Running Loop=1 2022-10-19T17:41:17.558Z,1666201277.558 [sci2:G] Stopped 2022-10-19T17:41:17.559Z,1666201277.559 [sci2:StartingMission] Running Loop=1 2022-10-19T17:41:17.559Z,1666201277.559 [sci2:StartingMission](DEBUG): Aggregate::initialize sci2:StartingMission 2022-10-19T17:41:18.030Z,1666201278.030 [sci2:NeedComms] Running Loop=1 2022-10-19T17:41:18.030Z,1666201278.030 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-19T17:41:18.030Z,1666201278.030 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-19T17:41:18.030Z,1666201278.030 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-19T17:41:18.030Z,1666201278.030 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-19T17:41:18.031Z,1666201278.031 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-19T17:41:18.039Z,1666201278.039 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-19T17:41:18.040Z,1666201278.040 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-19T17:41:18.040Z,1666201278.040 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-19T17:41:18.040Z,1666201278.040 [sci2:NeedComms:A] Running Loop=1 2022-10-19T17:41:18.041Z,1666201278.041 [sci2:NeedComms:A](INFO): last time_fix was: 1666201143.000000 second since 1970/01/01T00:00:00Z 2022-10-19T17:41:18.041Z,1666201278.041 [sci2:NeedComms:A] Stopped 2022-10-19T17:41:18.358Z,1666201278.358 [NAL9602](INFO): SBD MO Status=0, MOMSN=21689, MT Status=0, MTMSN=0 2022-10-19T17:41:18.664Z,1666201278.664 [sci2:NeedComms:C] Running Loop=1 2022-10-19T17:41:18.913Z,1666201278.913 [sci2:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2022-10-19T17:41:20.109Z,1666201280.109 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174119.00,A,3620.06085,N,12157.28799,W,1.847,162.94,191022,,,D*78 2022-10-19T17:41:20.111Z,1666201280.111 [NAL9602](INFO): GPS fix at 20221019T174119: (36.334347, -121.954800) 2022-10-19T17:41:20.170Z,1666201280.170 [sci2:NeedComms:C] Stopped 2022-10-19T17:41:20.170Z,1666201280.170 [sci2:NeedComms:D] Running Loop=1 2022-10-19T17:41:20.232Z,1666201280.232 [CTD_Seabird](ERROR): Failed to parse device response: 2022-10-19T17:41:20.552Z,1666201280.552 [sci2:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2022-10-19T17:41:46.927Z,1666201306.927 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:41:47.710Z,1666201307.710 [NAL9602](INFO): SBD MO Status=1, MOMSN=21690, MT Status=0, MTMSN=0 2022-10-19T17:41:47.762Z,1666201307.762 [NAL9602](INFO): Sent 39 bytes from file Logs/20221019T173951/Courier0003.lzma 2022-10-19T17:41:47.762Z,1666201307.762 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:42:07.595Z,1666201327.595 [NAL9602](INFO): SBD MO Status=1, MOMSN=21691, MT Status=0, MTMSN=0 2022-10-19T17:42:07.647Z,1666201327.647 [NAL9602](INFO): Sent 224 bytes from file Logs/20221019T173951/Courier0006.lzma 2022-10-19T17:42:07.647Z,1666201327.647 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:42:22.067Z,1666201342.067 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:42:38.766Z,1666201358.766 [NAL9602](INFO): SBD MO Status=1, MOMSN=21692, MT Status=0, MTMSN=0 2022-10-19T17:42:38.815Z,1666201358.815 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0004.lzma 2022-10-19T17:42:38.815Z,1666201358.815 [NAL9602](INFO): Packets left to send: 1 2022-10-19T17:42:48.986Z,1666201368.986 [NAL9602](INFO): SBD MO Status=1, MOMSN=21693, MT Status=0, MTMSN=0 2022-10-19T17:42:49.044Z,1666201369.044 [NAL9602](INFO): Sent 96 bytes from file Logs/20221019T173951/Express0004.lzma 2022-10-19T17:42:49.044Z,1666201369.044 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:42:57.207Z,1666201377.207 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:43:00.386Z,1666201380.386 [NAL9602](INFO): SBD MO Status=1, MOMSN=21694, MT Status=0, MTMSN=0 2022-10-19T17:43:00.447Z,1666201380.447 [NAL9602](INFO): Sent 62 bytes from file Logs/20221019T173951/Express0007.lzma 2022-10-19T17:43:00.447Z,1666201380.447 [NAL9602](INFO): Packets left to send: 0 2022-10-19T17:43:08.062Z,1666201388.062 [NAL9602](INFO): SBD MO Status=0, MOMSN=21695, MT Status=0, MTMSN=0 2022-10-19T17:43:08.179Z,1666201388.179 [sci2:NeedComms:D] Stopped 2022-10-19T17:43:08.180Z,1666201388.180 [sci2:NeedComms:E] Running Loop=1 2022-10-19T17:43:08.485Z,1666201388.485 [sci2:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2022-10-19T17:43:10.478Z,1666201390.478 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,174309.00,A,3620.04302,N,12157.30544,W,0.467,260.58,191022,,,D*70 2022-10-19T17:43:10.480Z,1666201390.480 [NAL9602](INFO): GPS fix at 20221019T174309: (36.334050, -121.955091) 2022-10-19T17:43:10.497Z,1666201390.497 [sci2:NeedComms:E] Stopped 2022-10-19T17:43:10.498Z,1666201390.498 [sci2:NeedComms](INFO): Completed sci2:NeedComms 2022-10-19T17:43:10.498Z,1666201390.498 [sci2:NeedComms] Stopped 2022-10-19T17:43:10.498Z,1666201390.498 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms 2022-10-19T17:43:10.498Z,1666201390.498 [sci2:NeedComms:B.GoToSurface] Stopped 2022-10-19T17:43:10.498Z,1666201390.498 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-19T17:43:10.915Z,1666201390.915 [sci2:StartingMission](INFO): Completed sci2:StartingMission 2022-10-19T17:43:10.915Z,1666201390.915 [sci2:StartingMission] Stopped 2022-10-19T17:43:10.915Z,1666201390.915 [sci2:StartingMission](DEBUG): Aggregate::uninitialize sci2:StartingMission 2022-10-19T17:43:10.916Z,1666201390.916 [sci2:Lap] Running Loop=1 2022-10-19T17:43:10.916Z,1666201390.916 [sci2:Lap](DEBUG): Aggregate::initialize sci2:Lap 2022-10-19T17:43:10.916Z,1666201390.916 [sci2:Lap:Wpt1] Running Loop=1 2022-10-19T17:43:10.916Z,1666201390.916 [sci2:Lap:Wpt1](DEBUG): Aggregate::initialize sci2:Lap:Wpt1 2022-10-19T17:43:10.916Z,1666201390.916 [sci2:Lap:Wpt1:A.Waypoint] Running Loop=1 2022-10-19T17:43:10.916Z,1666201390.916 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Initialize WaypointComponent. 2022-10-19T17:43:10.917Z,1666201390.917 [sci2:Lap:Wpt1:A.Waypoint](IMPORTANT): Navigating to waypoint: 36.322849,-121.943977 2022-10-19T17:43:32.347Z,1666201412.347 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:43:35.971Z,1666201415.971 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch -20.00 deg, mass-position 6.83 mm (3 active estimators). 2022-10-19T17:43:42.404Z,1666201422.404 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-19T17:44:07.487Z,1666201447.487 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:44:36.275Z,1666201476.275 [Radio_Surface](INFO): Powering down 2022-10-19T17:44:42.627Z,1666201482.627 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T17:44:43.631Z,1666201483.631 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T17:45:30.263Z,1666201530.263 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-19T17:45:39.156Z,1666201539.156 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position 6.83 mm (4 active estimators). 2022-10-19T17:45:40.042Z,1666201540.042 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T17:46:10.456Z,1666201570.456 [CTD_Seabird](ERROR): Failed to parse device response: 32,2901.30 2022-10-19T17:46:40.176Z,1666201600.176 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2022-10-19T17:47:47.679Z,1666201667.679 [CBIT](IMPORTANT): Beginning ground fault scan 2022-10-19T17:47:47.845Z,1666201667.845 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:48.849Z,1666201668.849 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:49.853Z,1666201669.853 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:50.857Z,1666201670.857 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:51.861Z,1666201671.861 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:52.865Z,1666201672.865 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:53.869Z,1666201673.869 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:54.873Z,1666201674.873 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:55.877Z,1666201675.877 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:56.881Z,1666201676.881 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:57.887Z,1666201677.887 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T17:47:58.594Z,1666201678.594 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.010942 CHAN A1 (24V): 0.000327 CHAN A2 (12V): -0.007597 CHAN A3 (5V): -0.002658 CHAN B0 (3.3V): 0.000322 CHAN B1 (3.15aV): 0.000280 CHAN B2 (3.15bV): 0.000380 CHAN B3 (GND): 0.002256 OPEN: 0.005406 Full Scale: +/- 1 mA 2022-10-19T18:06:56.209Z,1666202816.209 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T18:09:07.112Z,1666202947.112 [CTD_Seabird](ERROR): Failed to parse device response: .46 2022-10-19T18:13:11.551Z,1666203191.551 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T18:17:59.610Z,1666203479.610 [sci2:Lap:Wpt1:A.Waypoint](IMPORTANT): Reached waypoint: 36.322849,-121.943977 2022-10-19T18:17:59.610Z,1666203479.610 [sci2:Lap:Wpt1:A.Waypoint] Stopped 2022-10-19T18:17:59.610Z,1666203479.610 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Uninitialize WaypointComponent. 2022-10-19T18:17:59.611Z,1666203479.611 [sci2:Lap:Wpt1](INFO): Completed sci2:Lap:Wpt1 2022-10-19T18:17:59.611Z,1666203479.611 [sci2:Lap:Wpt1] Stopped 2022-10-19T18:17:59.611Z,1666203479.611 [sci2:Lap:Wpt1](DEBUG): Aggregate::uninitialize sci2:Lap:Wpt1 2022-10-19T18:17:59.611Z,1666203479.611 [sci2:Lap:Wpt2] Running Loop=1 2022-10-19T18:17:59.611Z,1666203479.611 [sci2:Lap:Wpt2](DEBUG): Aggregate::initialize sci2:Lap:Wpt2 2022-10-19T18:17:59.612Z,1666203479.612 [sci2:Lap:Wpt2:A.Waypoint] Running Loop=1 2022-10-19T18:17:59.612Z,1666203479.612 [sci2:Lap:Wpt2:A.Waypoint](DEBUG): Initialize WaypointComponent. 2022-10-19T18:17:59.613Z,1666203479.613 [sci2:Lap:Wpt2:A.Waypoint](IMPORTANT): Navigating to waypoint: 36.402557,-122.240234 2022-10-19T18:19:01.814Z,1666203541.814 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2022-10-19T18:26:04.068Z,1666203964.068 [RDI_Pathfinder](ERROR): only read -1 of 1 data item for altitude 2022-10-19T18:26:42.050Z,1666204002.050 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T18:27:12.286Z,1666204032.286 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T18:32:01.952Z,1666204321.952 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2022-10-19T18:32:01.954Z,1666204321.954 [BPC1](INFO): Received data from all battery sticks. 2022-10-19T18:37:40.162Z,1666204660.162 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2022-10-19T18:38:50.436Z,1666204730.436 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2022-10-19T18:43:10.608Z,1666204990.608 [sci2:NeedComms] Running Loop=1 2022-10-19T18:43:10.608Z,1666204990.608 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-19T18:43:10.608Z,1666204990.608 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-19T18:43:10.608Z,1666204990.608 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-19T18:43:10.609Z,1666204990.609 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-19T18:43:10.609Z,1666204990.609 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-19T18:43:10.609Z,1666204990.609 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-19T18:43:10.610Z,1666204990.610 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-19T18:43:10.610Z,1666204990.610 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-19T18:43:10.611Z,1666204990.611 [sci2:NeedComms:A] Running Loop=1 2022-10-19T18:43:10.612Z,1666204990.612 [sci2:NeedComms:A](INFO): last time_fix was: 1666201389.000000 second since 1970/01/01T00:00:00Z 2022-10-19T18:43:10.612Z,1666204990.612 [sci2:NeedComms:A] Stopped 2022-10-19T18:43:26.382Z,1666205006.382 [sci2:NeedComms:C] Running Loop=1 2022-10-19T18:43:26.971Z,1666205006.971 [Radio_Surface](INFO): Powering up 2022-10-19T18:43:32.247Z,1666205012.247 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-19T18:44:01.495Z,1666205041.495 [NAL9602](INFO): SBD MO Status=0, MOMSN=21696, MT Status=0, MTMSN=0 2022-10-19T18:44:01.496Z,1666205041.496 [NAL9602](INFO): No messages in MT queue 2022-10-19T18:44:02.367Z,1666205042.367 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T18:44:02.710Z,1666205042.710 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184401.00,A,3619.57477,N,12157.40535,W,0.505,271.99,191022,,,A*75 2022-10-19T18:44:02.712Z,1666205042.712 [NAL9602](INFO): GPS fix at 20221019T184401: (36.326246, -121.956756) 2022-10-19T18:44:02.744Z,1666205042.744 [UniversalFixResidualReporter](INFO): Fix residual: 1.9 %DT, over the last 3025.8 m. Residual distance 56.3 m at bearing -118.1 degrees. Fix at (36.3262, -121.9568) with 880.5 m made good. 2022-10-19T18:44:02.752Z,1666205042.752 [sci2:NeedComms:C] Stopped 2022-10-19T18:44:02.752Z,1666205042.752 [sci2:NeedComms:D] Running Loop=1 2022-10-19T18:44:23.884Z,1666205063.884 [NAL9602](INFO): SBD MO Status=2, MOMSN=21697, MT Status=2, MTMSN=0 2022-10-19T18:44:23.884Z,1666205063.884 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T18:44:37.511Z,1666205077.511 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T18:44:43.386Z,1666205083.386 [NAL9602](INFO): SBD MO Status=1, MOMSN=21697, MT Status=0, MTMSN=0 2022-10-19T18:44:43.436Z,1666205083.436 [NAL9602](INFO): Sent 263 bytes from file Logs/20221019T173951/Courier0009.lzma 2022-10-19T18:44:43.436Z,1666205083.436 [NAL9602](INFO): Packets left to send: 0 2022-10-19T18:45:01.270Z,1666205101.270 [NAL9602](INFO): SBD MO Status=1, MOMSN=21698, MT Status=0, MTMSN=0 2022-10-19T18:45:01.324Z,1666205101.324 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:45:01.324Z,1666205101.324 [NAL9602](INFO): Packets left to send: 8 2022-10-19T18:45:12.651Z,1666205112.651 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T18:45:23.646Z,1666205123.646 [NAL9602](INFO): SBD MO Status=1, MOMSN=21699, MT Status=0, MTMSN=0 2022-10-19T18:45:23.707Z,1666205123.707 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:45:23.707Z,1666205123.707 [NAL9602](INFO): Packets left to send: 7 2022-10-19T18:45:39.523Z,1666205139.523 [NAL9602](INFO): SBD MO Status=1, MOMSN=21700, MT Status=0, MTMSN=0 2022-10-19T18:45:39.571Z,1666205139.571 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:45:39.571Z,1666205139.571 [NAL9602](INFO): Packets left to send: 6 2022-10-19T18:45:47.791Z,1666205147.791 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T18:45:51.750Z,1666205151.750 [NAL9602](INFO): SBD MO Status=1, MOMSN=21701, MT Status=0, MTMSN=0 2022-10-19T18:45:51.799Z,1666205151.799 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:45:51.800Z,1666205151.800 [NAL9602](INFO): Packets left to send: 5 2022-10-19T18:46:04.094Z,1666205164.094 [NAL9602](INFO): SBD MO Status=1, MOMSN=21702, MT Status=0, MTMSN=0 2022-10-19T18:46:04.155Z,1666205164.155 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:46:04.155Z,1666205164.155 [NAL9602](INFO): Packets left to send: 4 2022-10-19T18:46:20.721Z,1666205180.721 [NAL9602](INFO): SBD MO Status=2, MOMSN=21703, MT Status=2, MTMSN=0 2022-10-19T18:46:20.721Z,1666205180.721 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T18:46:22.932Z,1666205182.932 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T18:46:41.870Z,1666205201.870 [NAL9602](INFO): SBD MO Status=2, MOMSN=21703, MT Status=2, MTMSN=0 2022-10-19T18:46:41.870Z,1666205201.870 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T18:46:58.085Z,1666205218.085 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T18:47:01.362Z,1666205221.362 [NAL9602](INFO): SBD MO Status=1, MOMSN=21703, MT Status=0, MTMSN=0 2022-10-19T18:47:01.415Z,1666205221.415 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:47:01.415Z,1666205221.415 [NAL9602](INFO): Packets left to send: 3 2022-10-19T18:47:20.463Z,1666205240.463 [NAL9602](INFO): SBD MO Status=2, MOMSN=21704, MT Status=2, MTMSN=0 2022-10-19T18:47:20.463Z,1666205240.463 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T18:47:41.302Z,1666205261.302 [NAL9602](INFO): SBD MO Status=1, MOMSN=21704, MT Status=0, MTMSN=0 2022-10-19T18:47:41.351Z,1666205261.351 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:47:41.352Z,1666205261.352 [NAL9602](INFO): Packets left to send: 2 2022-10-19T18:47:46.879Z,1666205266.879 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002802 2022-10-19T18:47:50.688Z,1666205270.688 [NAL9602](INFO): SBD MO Status=1, MOMSN=21705, MT Status=0, MTMSN=0 2022-10-19T18:47:50.737Z,1666205270.737 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:47:50.737Z,1666205270.737 [NAL9602](INFO): Packets left to send: 1 2022-10-19T18:48:03.951Z,1666205283.951 [DataOverHttps](INFO): Sending 2853 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:48:17.999Z,1666205297.999 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2022-10-19T18:48:21.381Z,1666205301.381 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-19T18:48:32.812Z,1666205312.812 [DataOverHttps](INFO): Sending 2853 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:48:47.866Z,1666205327.866 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.989506 2022-10-19T18:49:01.130Z,1666205341.130 [NAL9602](INFO): SBD MO Status=1, MOMSN=21706, MT Status=0, MTMSN=0 2022-10-19T18:49:01.191Z,1666205341.191 [NAL9602](INFO): Sent 197 bytes from file Logs/20221019T173951/Express0010.lzma 2022-10-19T18:49:01.192Z,1666205341.192 [NAL9602](INFO): Packets left to send: 0 2022-10-19T18:49:09.175Z,1666205349.175 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002691 2022-10-19T18:49:10.481Z,1666205350.481 [sci2:NeedComms:D] Stopped 2022-10-19T18:49:10.481Z,1666205350.481 [sci2:NeedComms:E] Running Loop=1 2022-10-19T18:49:11.634Z,1666205351.634 [NAL9602](INFO): SBD MO Status=0, MOMSN=21707, MT Status=0, MTMSN=0 2022-10-19T18:49:12.842Z,1666205352.842 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184911.00,A,3619.55224,N,12157.47596,W,0.972,209.72,191022,,,A*73 2022-10-19T18:49:12.844Z,1666205352.844 [NAL9602](INFO): GPS fix at 20221019T184911: (36.325871, -121.957933) 2022-10-19T18:49:12.900Z,1666205352.900 [sci2:NeedComms:E] Stopped 2022-10-19T18:49:12.900Z,1666205352.900 [sci2:NeedComms](INFO): Completed sci2:NeedComms 2022-10-19T18:49:12.900Z,1666205352.900 [sci2:NeedComms] Stopped 2022-10-19T18:49:12.901Z,1666205352.901 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms 2022-10-19T18:49:12.901Z,1666205352.901 [sci2:NeedComms:B.GoToSurface] Stopped 2022-10-19T18:49:12.901Z,1666205352.901 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-19T18:49:13.664Z,1666205353.664 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch -10.00 deg, mass-position 6.83 mm. 2022-10-19T18:49:28.209Z,1666205368.209 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T18:49:45.565Z,1666205385.565 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-19T18:49:58.191Z,1666205398.191 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2022-10-19T18:49:58.191Z,1666205398.191 [RDI_Pathfinder] Communications Fault, FailCount= 1 2022-10-19T18:49:58.191Z,1666205398.191 [RDI_Pathfinder](ERROR): Communications Fault 2022-10-19T18:49:58.415Z,1666205398.415 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2022-10-19T18:49:58.567Z,1666205398.567 [RDI_Pathfinder](INFO): Powering down 2022-10-19T18:49:59.452Z,1666205399.452 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2022-10-19T18:49:59.452Z,1666205399.452 [RDI_Pathfinder] No Fault, FailCount= 1 2022-10-19T18:49:59.724Z,1666205399.724 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2022-10-19T18:50:51.588Z,1666205451.588 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T18:50:58.616Z,1666205458.616 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.243408 2022-10-19T18:51:20.620Z,1666205480.620 [Radio_Surface](INFO): Powering down 2022-10-19T18:51:20.703Z,1666205480.703 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T18:55:39.486Z,1666205739.486 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T18:56:43.800Z,1666205803.800 [CTD_Seabird](ERROR): Failed to parse device response: ,12.3069,3.86376,3149.11 2022-10-19T18:59:17.452Z,1666205957.452 [CTD_Seabird](ERROR): Failed to parse device response: 91,3801.67 2022-10-19T19:09:49.103Z,1666206589.103 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T19:10:09.315Z,1666206609.315 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-19T19:10:19.035Z,1666206619.035 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T19:10:29.121Z,1666206629.121 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T19:10:49.335Z,1666206649.335 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T19:15:16.896Z,1666206916.896 [ThrusterServo](FAULT): getVelocity uart error serial timeout 2022-10-19T19:15:16.896Z,1666206916.896 [ThrusterServo](FAULT): Thruster uart error: serial timeout 2022-10-19T19:15:16.896Z,1666206916.896 [ThrusterServo] Communications Fault, FailCount= 1 2022-10-19T19:15:16.896Z,1666206916.896 [ThrusterServo](ERROR): Communications Fault 2022-10-19T19:15:16.910Z,1666206916.910 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2022-10-19T19:15:17.216Z,1666206917.216 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2022-10-19T19:15:17.216Z,1666206917.216 [ThrusterServo](INFO): Powering down 2022-10-19T19:15:17.994Z,1666206917.994 [ThrusterServo](DEBUG): Initializing EZServoServo. 2022-10-19T19:15:18.109Z,1666206918.109 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2022-10-19T19:15:18.113Z,1666206918.113 [CBIT](INFO): Clearing failed state for component ThrusterServo 2022-10-19T19:15:18.113Z,1666206918.113 [ThrusterServo] No Fault, FailCount= 1 2022-10-19T19:18:47.283Z,1666207127.283 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2022-10-19T19:19:56.428Z,1666207196.428 [CTD_Seabird](ERROR): Failed to parse device response: ,12.4246,3.87209,3240.72 2022-10-19T19:23:14.259Z,1666207394.259 [RudderServo](ERROR): getPosition uart error serial timeout 2022-10-19T19:23:14.259Z,1666207394.259 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout 2022-10-19T19:23:14.259Z,1666207394.259 [RudderServo] Communications Fault, FailCount= 1 2022-10-19T19:23:14.259Z,1666207394.259 [RudderServo](ERROR): Communications Fault 2022-10-19T19:23:14.291Z,1666207394.291 [CBIT](ERROR): Communications Fault in component: RudderServo 2022-10-19T19:23:14.370Z,1666207394.370 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-10-19T19:23:14.370Z,1666207394.370 [RudderServo](INFO): Powering down 2022-10-19T19:23:15.205Z,1666207395.205 [RudderServo](DEBUG): Initializing EZServoServo. 2022-10-19T19:23:15.328Z,1666207395.328 [RudderServo](DEBUG): Initializing RudderServo. 2022-10-19T19:23:15.359Z,1666207395.359 [CBIT](INFO): Clearing failed state for component RudderServo 2022-10-19T19:23:15.359Z,1666207395.359 [RudderServo] No Fault, FailCount= 1 2022-10-19T19:24:45.211Z,1666207485.211 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T19:30:45.191Z,1666207845.191 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-19T19:30:55.286Z,1666207855.286 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T19:33:09.082Z,1666207989.082 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T19:39:34.049Z,1666208374.049 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2022-10-19T19:39:34.052Z,1666208374.052 [BPC1](INFO): Received data from all battery sticks. 2022-10-19T19:47:58.792Z,1666208878.792 [CBIT](IMPORTANT): Beginning ground fault scan 2022-10-19T19:47:59.421Z,1666208879.421 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:00.463Z,1666208880.463 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:01.463Z,1666208881.463 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:02.471Z,1666208882.471 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:03.471Z,1666208883.471 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:04.467Z,1666208884.467 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:05.467Z,1666208885.467 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:06.471Z,1666208886.471 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:07.463Z,1666208887.463 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:08.471Z,1666208888.471 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:09.471Z,1666208889.471 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T19:48:09.658Z,1666208889.658 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.009788 CHAN A1 (24V): 0.000240 CHAN A2 (12V): -0.006791 CHAN A3 (5V): -0.001859 CHAN B0 (3.3V): 0.000214 CHAN B1 (3.15aV): -0.000676 CHAN B2 (3.15bV): -0.000348 CHAN B3 (GND): 0.001901 OPEN: 0.005444 Full Scale: +/- 1 mA 2022-10-19T19:50:40.716Z,1666209040.716 [sci2:NeedComms] Running Loop=1 2022-10-19T19:50:40.716Z,1666209040.716 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-19T19:50:40.716Z,1666209040.716 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-19T19:50:40.716Z,1666209040.716 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-19T19:50:40.716Z,1666209040.716 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-19T19:50:40.717Z,1666209040.717 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-19T19:50:40.717Z,1666209040.717 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-19T19:50:40.717Z,1666209040.717 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-19T19:50:40.718Z,1666209040.718 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-19T19:50:40.718Z,1666209040.718 [sci2:NeedComms:A] Running Loop=1 2022-10-19T19:50:40.720Z,1666209040.720 [sci2:NeedComms:A](INFO): last time_fix was: 1666205351.000000 second since 1970/01/01T00:00:00Z 2022-10-19T19:50:40.720Z,1666209040.720 [sci2:NeedComms:A] Stopped 2022-10-19T19:53:11.440Z,1666209191.440 [sci2:NeedComms:C] Running Loop=1 2022-10-19T19:53:12.087Z,1666209192.087 [Radio_Surface](INFO): Powering up 2022-10-19T19:53:17.819Z,1666209197.819 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-19T19:53:42.900Z,1666209222.900 [NAL9602](INFO): SBD MO Status=0, MOMSN=21708, MT Status=0, MTMSN=0 2022-10-19T19:53:42.900Z,1666209222.900 [NAL9602](INFO): No messages in MT queue 2022-10-19T19:53:44.114Z,1666209224.114 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195343.00,A,3620.17220,N,12159.28484,W,1.497,341.38,191022,,,A*77 2022-10-19T19:53:44.116Z,1666209224.116 [NAL9602](INFO): GPS fix at 20221019T195343: (36.336203, -121.988081) 2022-10-19T19:53:44.150Z,1666209224.150 [UniversalFixResidualReporter](INFO): Fix residual: 6.2 %DT, over the last 2993.0 m. Residual distance 187.0 m at bearing -160.4 degrees. Fix at (36.3362, -121.9881) with 2934.9 m made good. 2022-10-19T19:53:44.158Z,1666209224.158 [sci2:NeedComms:C] Stopped 2022-10-19T19:53:44.158Z,1666209224.158 [sci2:NeedComms:D] Running Loop=1 2022-10-19T19:53:47.940Z,1666209227.940 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T19:53:56.378Z,1666209236.378 [NAL9602](INFO): SBD MO Status=1, MOMSN=21709, MT Status=0, MTMSN=0 2022-10-19T19:53:56.439Z,1666209236.439 [NAL9602](INFO): Sent 95 bytes from file Logs/20221019T173951/Courier0012.lzma 2022-10-19T19:53:56.440Z,1666209236.440 [NAL9602](INFO): Packets left to send: 0 2022-10-19T19:54:15.882Z,1666209255.882 [NAL9602](INFO): SBD MO Status=1, MOMSN=21710, MT Status=0, MTMSN=0 2022-10-19T19:54:15.931Z,1666209255.931 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:54:15.931Z,1666209255.931 [NAL9602](INFO): Packets left to send: 8 2022-10-19T19:54:23.080Z,1666209263.080 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T19:54:32.961Z,1666209272.961 [NAL9602](INFO): SBD MO Status=1, MOMSN=21711, MT Status=0, MTMSN=0 2022-10-19T19:54:33.011Z,1666209273.011 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:54:33.011Z,1666209273.011 [NAL9602](INFO): Packets left to send: 7 2022-10-19T19:54:47.338Z,1666209287.338 [NAL9602](INFO): SBD MO Status=1, MOMSN=21712, MT Status=0, MTMSN=0 2022-10-19T19:54:47.399Z,1666209287.399 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:54:47.399Z,1666209287.399 [NAL9602](INFO): Packets left to send: 6 2022-10-19T19:54:58.219Z,1666209298.219 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T19:55:06.833Z,1666209306.833 [NAL9602](INFO): SBD MO Status=1, MOMSN=21713, MT Status=0, MTMSN=0 2022-10-19T19:55:06.891Z,1666209306.891 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:55:06.891Z,1666209306.891 [NAL9602](INFO): Packets left to send: 5 2022-10-19T19:55:21.079Z,1666209321.079 [NAL9602](INFO): SBD MO Status=1, MOMSN=21714, MT Status=0, MTMSN=0 2022-10-19T19:55:21.127Z,1666209321.127 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:55:21.127Z,1666209321.127 [NAL9602](INFO): Packets left to send: 4 2022-10-19T19:55:33.360Z,1666209333.360 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T19:55:39.329Z,1666209339.329 [NAL9602](INFO): SBD MO Status=2, MOMSN=21715, MT Status=2, MTMSN=0 2022-10-19T19:55:39.330Z,1666209339.330 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T19:56:04.458Z,1666209364.458 [NAL9602](INFO): SBD MO Status=1, MOMSN=21715, MT Status=0, MTMSN=0 2022-10-19T19:56:04.527Z,1666209364.527 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:56:04.527Z,1666209364.527 [NAL9602](INFO): Packets left to send: 3 2022-10-19T19:56:08.519Z,1666209368.519 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T19:56:18.260Z,1666209378.260 [NAL9602](INFO): SBD MO Status=1, MOMSN=21716, MT Status=0, MTMSN=0 2022-10-19T19:56:18.315Z,1666209378.315 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:56:18.315Z,1666209378.315 [NAL9602](INFO): Packets left to send: 2 2022-10-19T19:56:29.657Z,1666209389.657 [NAL9602](INFO): SBD MO Status=1, MOMSN=21717, MT Status=0, MTMSN=0 2022-10-19T19:56:29.707Z,1666209389.707 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:56:29.707Z,1666209389.707 [NAL9602](INFO): Packets left to send: 1 2022-10-19T19:56:41.098Z,1666209401.098 [NAL9602](INFO): SBD MO Status=1, MOMSN=21718, MT Status=0, MTMSN=0 2022-10-19T19:56:41.155Z,1666209401.155 [NAL9602](INFO): Sent 80 bytes from file Logs/20221019T173951/Express0013.lzma 2022-10-19T19:56:41.155Z,1666209401.155 [NAL9602](INFO): Packets left to send: 0 2022-10-19T19:56:43.663Z,1666209403.663 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T19:56:49.158Z,1666209409.158 [NAL9602](INFO): SBD MO Status=0, MOMSN=21719, MT Status=0, MTMSN=0 2022-10-19T19:56:49.261Z,1666209409.261 [sci2:NeedComms:D] Stopped 2022-10-19T19:56:49.261Z,1666209409.261 [sci2:NeedComms:E] Running Loop=1 2022-10-19T19:56:51.570Z,1666209411.570 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,195650.00,A,3620.17931,N,12159.26334,W,0.583,43.91,191022,,,D*4B 2022-10-19T19:56:51.572Z,1666209411.572 [NAL9602](INFO): GPS fix at 20221019T195650: (36.336322, -121.987722) 2022-10-19T19:56:51.608Z,1666209411.608 [sci2:NeedComms:E] Stopped 2022-10-19T19:56:51.609Z,1666209411.609 [sci2:NeedComms](INFO): Completed sci2:NeedComms 2022-10-19T19:56:51.609Z,1666209411.609 [sci2:NeedComms] Stopped 2022-10-19T19:56:51.609Z,1666209411.609 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms 2022-10-19T19:56:51.609Z,1666209411.609 [sci2:NeedComms:B.GoToSurface] Stopped 2022-10-19T19:56:51.609Z,1666209411.609 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-19T19:56:52.391Z,1666209412.391 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -20.00 mm. 2022-10-19T19:57:06.241Z,1666209426.241 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004304 2022-10-19T19:57:23.516Z,1666209443.516 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-19T19:57:54.792Z,1666209474.792 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2022-10-19T19:58:06.840Z,1666209486.840 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.603176 2022-10-19T19:58:53.511Z,1666209533.511 [Radio_Surface](INFO): Powering down 2022-10-19T19:59:05.077Z,1666209545.077 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T19:59:06.079Z,1666209546.079 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T20:00:33.401Z,1666209633.401 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2022-10-19T20:12:37.381Z,1666210357.381 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T20:12:57.186Z,1666210377.186 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T20:13:17.402Z,1666210397.402 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T20:13:47.315Z,1666210427.315 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2022-10-19T20:13:47.315Z,1666210427.315 [RDI_Pathfinder] Communications Fault, FailCount= 1 2022-10-19T20:13:47.315Z,1666210427.315 [RDI_Pathfinder](ERROR): Communications Fault 2022-10-19T20:13:47.407Z,1666210427.407 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2022-10-19T20:13:47.747Z,1666210427.747 [RDI_Pathfinder](INFO): Powering down 2022-10-19T20:13:48.583Z,1666210428.583 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2022-10-19T20:13:48.583Z,1666210428.583 [RDI_Pathfinder] No Fault, FailCount= 1 2022-10-19T20:13:48.887Z,1666210428.887 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2022-10-19T20:16:22.430Z,1666210582.430 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T20:27:26.601Z,1666211246.601 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T20:29:11.555Z,1666211351.555 [Radio_Surface](INFO): Powering up 2022-10-19T20:29:17.615Z,1666211357.615 [Radio_Surface](INFO): Powering down 2022-10-19T20:37:58.488Z,1666211878.488 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T20:38:08.578Z,1666211888.578 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T20:46:59.841Z,1666212419.841 [BPC1](INFO): Calculating totals. Valid battery stick count: 54. Valid reserve battery stick count: 6. 2022-10-19T20:46:59.843Z,1666212419.843 [BPC1](INFO): Received data from all battery sticks. 2022-10-19T20:49:08.729Z,1666212548.729 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T20:58:34.772Z,1666213114.772 [sci2:NeedComms] Running Loop=1 2022-10-19T20:58:34.773Z,1666213114.773 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-19T20:58:34.773Z,1666213114.773 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-19T20:58:34.773Z,1666213114.773 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-19T20:58:34.773Z,1666213114.773 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-19T20:58:34.774Z,1666213114.774 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-19T20:58:34.774Z,1666213114.774 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-19T20:58:34.774Z,1666213114.774 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-19T20:58:34.775Z,1666213114.775 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-19T20:58:34.775Z,1666213114.775 [sci2:NeedComms:A] Running Loop=1 2022-10-19T20:58:34.777Z,1666213114.777 [sci2:NeedComms:A](INFO): last time_fix was: 1666209410.000000 second since 1970/01/01T00:00:00Z 2022-10-19T20:58:34.777Z,1666213114.777 [sci2:NeedComms:A] Stopped 2022-10-19T20:59:14.411Z,1666213154.411 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-19T21:00:04.438Z,1666213204.438 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2022-10-19T21:00:14.551Z,1666213214.551 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2022-10-19T21:00:24.645Z,1666213224.645 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T21:00:50.090Z,1666213250.090 [sci2:NeedComms:C] Running Loop=1 2022-10-19T21:00:50.799Z,1666213250.799 [Radio_Surface](INFO): Powering up 2022-10-19T21:00:56.259Z,1666213256.259 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-19T21:01:09.066Z,1666213269.066 [NAL9602](INFO): SBD MO Status=0, MOMSN=21720, MT Status=0, MTMSN=0 2022-10-19T21:01:09.066Z,1666213269.066 [NAL9602](INFO): No messages in MT queue 2022-10-19T21:01:10.282Z,1666213270.282 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210109.00,A,3620.59136,N,12200.83351,W,0.467,353.68,191022,,,A*72 2022-10-19T21:01:10.284Z,1666213270.284 [NAL9602](INFO): GPS fix at 20221019T210109: (36.343189, -122.013892) 2022-10-19T21:01:10.297Z,1666213270.297 [UniversalFixResidualReporter](INFO): Fix residual: 7.3 %DT, over the last 2683.2 m. Residual distance 196.1 m at bearing -145.8 degrees. Fix at (36.3432, -122.0139) with 2465.2 m made good. 2022-10-19T21:01:10.301Z,1666213270.301 [sci2:NeedComms:C] Stopped 2022-10-19T21:01:10.301Z,1666213270.301 [sci2:NeedComms:D] Running Loop=1 2022-10-19T21:01:26.393Z,1666213286.393 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:01:39.706Z,1666213299.706 [NAL9602](INFO): SBD MO Status=1, MOMSN=21721, MT Status=0, MTMSN=0 2022-10-19T21:01:39.755Z,1666213299.755 [NAL9602](INFO): Sent 95 bytes from file Logs/20221019T173951/Courier0015.lzma 2022-10-19T21:01:39.755Z,1666213299.755 [NAL9602](INFO): Packets left to send: 0 2022-10-19T21:01:51.562Z,1666213311.562 [NAL9602](INFO): SBD MO Status=1, MOMSN=21722, MT Status=0, MTMSN=0 2022-10-19T21:01:51.623Z,1666213311.623 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:01:51.623Z,1666213311.623 [NAL9602](INFO): Packets left to send: 7 2022-10-19T21:02:01.539Z,1666213321.539 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:02:02.568Z,1666213322.568 [NAL9602](INFO): SBD MO Status=1, MOMSN=21723, MT Status=0, MTMSN=0 2022-10-19T21:02:02.627Z,1666213322.627 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:02:02.627Z,1666213322.627 [NAL9602](INFO): Packets left to send: 6 2022-10-19T21:02:07.832Z,1666213327.832 [CTD_Seabird](ERROR): Failed to parse device response: 24,4035.76 2022-10-19T21:02:12.014Z,1666213332.014 [NAL9602](INFO): SBD MO Status=1, MOMSN=21724, MT Status=0, MTMSN=0 2022-10-19T21:02:12.063Z,1666213332.063 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:02:12.063Z,1666213332.063 [NAL9602](INFO): Packets left to send: 5 2022-10-19T21:02:35.522Z,1666213355.522 [NAL9602](INFO): SBD MO Status=1, MOMSN=21725, MT Status=0, MTMSN=0 2022-10-19T21:02:35.571Z,1666213355.571 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:02:35.571Z,1666213355.571 [NAL9602](INFO): Packets left to send: 4 2022-10-19T21:02:36.685Z,1666213356.685 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:02:46.919Z,1666213366.919 [NAL9602](INFO): SBD MO Status=1, MOMSN=21726, MT Status=0, MTMSN=0 2022-10-19T21:02:46.972Z,1666213366.972 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:02:46.973Z,1666213366.973 [NAL9602](INFO): Packets left to send: 3 2022-10-19T21:02:59.149Z,1666213379.149 [NAL9602](INFO): SBD MO Status=1, MOMSN=21727, MT Status=0, MTMSN=0 2022-10-19T21:02:59.203Z,1666213379.203 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:02:59.203Z,1666213379.203 [NAL9602](INFO): Packets left to send: 2 2022-10-19T21:03:11.823Z,1666213391.823 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:03:12.680Z,1666213392.680 [NAL9602](INFO): SBD MO Status=1, MOMSN=21728, MT Status=0, MTMSN=0 2022-10-19T21:03:12.727Z,1666213392.727 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:03:12.727Z,1666213392.727 [NAL9602](INFO): Packets left to send: 1 2022-10-19T21:03:25.410Z,1666213405.410 [NAL9602](INFO): SBD MO Status=1, MOMSN=21729, MT Status=0, MTMSN=0 2022-10-19T21:03:25.471Z,1666213405.471 [NAL9602](INFO): Sent 119 bytes from file Logs/20221019T173951/Express0016.lzma 2022-10-19T21:03:25.471Z,1666213405.471 [NAL9602](INFO): Packets left to send: 0 2022-10-19T21:03:36.324Z,1666213416.324 [NAL9602](INFO): SBD MO Status=0, MOMSN=21730, MT Status=0, MTMSN=0 2022-10-19T21:03:36.420Z,1666213416.420 [sci2:NeedComms:D] Stopped 2022-10-19T21:03:36.420Z,1666213416.420 [sci2:NeedComms:E] Running Loop=1 2022-10-19T21:03:38.738Z,1666213418.738 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,210337.00,A,3620.59019,N,12200.81752,W,0.991,120.07,191022,,,A*7F 2022-10-19T21:03:38.743Z,1666213418.743 [NAL9602](INFO): GPS fix at 20221019T210337: (36.343170, -122.013625) 2022-10-19T21:03:38.804Z,1666213418.804 [sci2:NeedComms:E] Stopped 2022-10-19T21:03:38.805Z,1666213418.805 [sci2:NeedComms](INFO): Completed sci2:NeedComms 2022-10-19T21:03:38.805Z,1666213418.805 [sci2:NeedComms] Stopped 2022-10-19T21:03:38.805Z,1666213418.805 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms 2022-10-19T21:03:38.805Z,1666213418.805 [sci2:NeedComms:B.GoToSurface] Stopped 2022-10-19T21:03:38.805Z,1666213418.805 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-19T21:03:46.971Z,1666213426.971 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:04:10.692Z,1666213450.692 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-19T21:04:22.112Z,1666213462.112 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:04:57.268Z,1666213497.268 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:05:06.155Z,1666213506.155 [Radio_Surface](INFO): Powering down 2022-10-19T21:05:32.419Z,1666213532.419 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:05:33.423Z,1666213533.423 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T21:12:43.928Z,1666213963.928 [Radio_Surface](INFO): Powering up 2022-10-19T21:12:49.219Z,1666213969.219 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-19T21:12:49.988Z,1666213969.988 [Radio_Surface](INFO): Powering down 2022-10-19T21:13:19.339Z,1666213999.339 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T21:13:20.343Z,1666214000.343 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T21:20:20.722Z,1666214420.722 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T21:21:00.747Z,1666214460.747 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T21:29:30.608Z,1666214970.608 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T21:41:26.513Z,1666215686.513 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T21:42:46.527Z,1666215766.527 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2022-10-19T21:48:09.763Z,1666216089.763 [CBIT](IMPORTANT): Beginning ground fault scan 2022-10-19T21:48:10.277Z,1666216090.277 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:11.280Z,1666216091.280 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:12.285Z,1666216092.285 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:13.289Z,1666216093.289 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:14.293Z,1666216094.293 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:15.297Z,1666216095.297 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:16.301Z,1666216096.301 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:17.304Z,1666216097.304 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:18.309Z,1666216098.309 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:19.313Z,1666216099.313 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:20.318Z,1666216100.318 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T21:48:20.730Z,1666216100.730 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.010804 CHAN A1 (24V): -0.000334 CHAN A2 (12V): -0.006635 CHAN A3 (5V): -0.001787 CHAN B0 (3.3V): 0.000249 CHAN B1 (3.15aV): -0.000193 CHAN B2 (3.15bV): -0.000335 CHAN B3 (GND): 0.001922 OPEN: 0.005230 Full Scale: +/- 1 mA 2022-10-19T21:54:28.733Z,1666216468.733 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2022-10-19T21:54:28.735Z,1666216468.735 [BPC1](INFO): Received data from all battery sticks. 2022-10-19T21:56:42.864Z,1666216602.864 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T22:05:46.693Z,1666217146.693 [sci2:NeedComms] Running Loop=1 2022-10-19T22:05:46.694Z,1666217146.694 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-19T22:05:46.694Z,1666217146.694 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-19T22:05:46.694Z,1666217146.694 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-19T22:05:46.694Z,1666217146.694 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-19T22:05:46.695Z,1666217146.694 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-19T22:05:46.709Z,1666217146.709 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-19T22:05:46.710Z,1666217146.710 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-19T22:05:46.710Z,1666217146.710 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-19T22:05:46.715Z,1666217146.715 [sci2:NeedComms:A] Running Loop=1 2022-10-19T22:05:46.717Z,1666217146.717 [sci2:NeedComms:A](INFO): last time_fix was: 1666213417.000000 second since 1970/01/01T00:00:00Z 2022-10-19T22:05:46.717Z,1666217146.717 [sci2:NeedComms:A] Stopped 2022-10-19T22:08:01.236Z,1666217281.236 [sci2:NeedComms:C] Running Loop=1 2022-10-19T22:08:01.799Z,1666217281.799 [Radio_Surface](INFO): Powering up 2022-10-19T22:08:07.942Z,1666217287.942 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-19T22:08:27.440Z,1666217307.440 [NAL9602](INFO): SBD MO Status=0, MOMSN=21731, MT Status=0, MTMSN=0 2022-10-19T22:08:27.441Z,1666217307.441 [NAL9602](INFO): No messages in MT queue 2022-10-19T22:08:28.658Z,1666217308.658 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,220827.00,A,3620.85109,N,12202.41197,W,0.389,308.47,191022,,,A*79 2022-10-19T22:08:28.660Z,1666217308.660 [NAL9602](INFO): GPS fix at 20221019T220827: (36.347518, -122.040199) 2022-10-19T22:08:28.725Z,1666217308.725 [UniversalFixResidualReporter](INFO): Fix residual: 10.1 %DT, over the last 3252.0 m. Residual distance 327.5 m at bearing -53.1 degrees. Fix at (36.3475, -122.0402) with 2428.7 m made good. 2022-10-19T22:08:28.739Z,1666217308.739 [sci2:NeedComms:C] Stopped 2022-10-19T22:08:28.739Z,1666217308.739 [sci2:NeedComms:D] Running Loop=1 2022-10-19T22:08:38.060Z,1666217318.060 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:08:39.559Z,1666217319.559 [NAL9602](INFO): SBD MO Status=1, MOMSN=21732, MT Status=0, MTMSN=0 2022-10-19T22:08:39.610Z,1666217319.610 [NAL9602](INFO): Sent 95 bytes from file Logs/20221019T173951/Courier0018.lzma 2022-10-19T22:08:39.610Z,1666217319.610 [NAL9602](INFO): Packets left to send: 0 2022-10-19T22:08:52.668Z,1666217332.668 [NAL9602](INFO): SBD MO Status=1, MOMSN=21733, MT Status=0, MTMSN=0 2022-10-19T22:08:52.719Z,1666217332.719 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:08:52.720Z,1666217332.720 [NAL9602](INFO): Packets left to send: 8 2022-10-19T22:09:01.370Z,1666217341.370 [NAL9602](INFO): SBD MO Status=1, MOMSN=21734, MT Status=0, MTMSN=0 2022-10-19T22:09:01.419Z,1666217341.419 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:09:01.419Z,1666217341.419 [NAL9602](INFO): Packets left to send: 7 2022-10-19T22:09:12.558Z,1666217352.558 [NAL9602](INFO): SBD MO Status=1, MOMSN=21735, MT Status=0, MTMSN=0 2022-10-19T22:09:12.619Z,1666217352.619 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:09:12.619Z,1666217352.619 [NAL9602](INFO): Packets left to send: 6 2022-10-19T22:09:13.199Z,1666217353.199 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:09:24.330Z,1666217364.330 [NAL9602](INFO): SBD MO Status=1, MOMSN=21736, MT Status=0, MTMSN=0 2022-10-19T22:09:24.383Z,1666217364.383 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:09:24.383Z,1666217364.383 [NAL9602](INFO): Packets left to send: 5 2022-10-19T22:09:35.721Z,1666217375.721 [NAL9602](INFO): SBD MO Status=1, MOMSN=21737, MT Status=0, MTMSN=0 2022-10-19T22:09:35.771Z,1666217375.771 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:09:35.771Z,1666217375.771 [NAL9602](INFO): Packets left to send: 4 2022-10-19T22:09:47.112Z,1666217387.112 [NAL9602](INFO): SBD MO Status=1, MOMSN=21738, MT Status=0, MTMSN=0 2022-10-19T22:09:47.175Z,1666217387.175 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:09:47.175Z,1666217387.175 [NAL9602](INFO): Packets left to send: 3 2022-10-19T22:09:48.351Z,1666217388.351 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:09:59.005Z,1666217399.005 [NAL9602](INFO): SBD MO Status=1, MOMSN=21739, MT Status=0, MTMSN=0 2022-10-19T22:09:59.055Z,1666217399.055 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:09:59.055Z,1666217399.055 [NAL9602](INFO): Packets left to send: 2 2022-10-19T22:10:16.921Z,1666217416.921 [NAL9602](INFO): SBD MO Status=2, MOMSN=21740, MT Status=2, MTMSN=0 2022-10-19T22:10:16.922Z,1666217416.922 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T22:10:23.499Z,1666217423.499 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:10:42.552Z,1666217442.552 [NAL9602](INFO): SBD MO Status=2, MOMSN=21740, MT Status=2, MTMSN=0 2022-10-19T22:10:42.552Z,1666217442.552 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T22:10:58.643Z,1666217458.643 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:11:12.554Z,1666217472.554 [NAL9602](INFO): SBD MO Status=1, MOMSN=21740, MT Status=0, MTMSN=0 2022-10-19T22:11:12.603Z,1666217472.603 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:11:12.603Z,1666217472.603 [NAL9602](INFO): Packets left to send: 1 2022-10-19T22:11:30.433Z,1666217490.433 [NAL9602](INFO): SBD MO Status=2, MOMSN=21741, MT Status=2, MTMSN=0 2022-10-19T22:11:30.434Z,1666217490.434 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T22:11:33.808Z,1666217493.808 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:11:57.232Z,1666217517.232 [NAL9602](INFO): SBD MO Status=2, MOMSN=21741, MT Status=2, MTMSN=0 2022-10-19T22:11:57.232Z,1666217517.232 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T22:12:08.956Z,1666217528.956 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:12:23.645Z,1666217543.645 [NAL9602](INFO): SBD MO Status=2, MOMSN=21741, MT Status=2, MTMSN=0 2022-10-19T22:12:23.646Z,1666217543.646 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T22:12:44.103Z,1666217564.103 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:12:44.320Z,1666217564.320 [NAL9602](INFO): SBD MO Status=1, MOMSN=21741, MT Status=0, MTMSN=0 2022-10-19T22:12:44.371Z,1666217564.371 [NAL9602](INFO): Sent 240 bytes from file Logs/20221019T173951/Express0019.lzma 2022-10-19T22:12:44.371Z,1666217564.371 [NAL9602](INFO): Packets left to send: 0 2022-10-19T22:12:54.430Z,1666217574.430 [NAL9602](INFO): SBD MO Status=0, MOMSN=21742, MT Status=0, MTMSN=0 2022-10-19T22:12:54.558Z,1666217574.558 [sci2:NeedComms:D] Stopped 2022-10-19T22:12:54.561Z,1666217574.561 [sci2:NeedComms:E] Running Loop=1 2022-10-19T22:12:56.850Z,1666217576.850 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221255.00,A,3620.84374,N,12202.41022,W,1.050,250.28,191022,,,D*77 2022-10-19T22:12:56.852Z,1666217576.852 [NAL9602](INFO): GPS fix at 20221019T221255: (36.347396, -122.040170) 2022-10-19T22:12:56.916Z,1666217576.916 [sci2:NeedComms:E] Stopped 2022-10-19T22:12:56.916Z,1666217576.916 [sci2:NeedComms](INFO): Completed sci2:NeedComms 2022-10-19T22:12:56.917Z,1666217576.917 [sci2:NeedComms] Stopped 2022-10-19T22:12:56.917Z,1666217576.917 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms 2022-10-19T22:12:56.917Z,1666217576.917 [sci2:NeedComms:B.GoToSurface] Stopped 2022-10-19T22:12:56.917Z,1666217576.917 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-19T22:12:57.664Z,1666217577.664 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch -20.00 deg, mass-position 6.83 mm. 2022-10-19T22:12:57.664Z,1666217577.664 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position 6.83 mm. 2022-10-19T22:12:58.671Z,1666217578.671 [ThrusterServo](ERROR): Thruster uart error: serial timeout 2022-10-19T22:12:58.671Z,1666217578.671 [ThrusterServo] Communications Fault, FailCount= 1 2022-10-19T22:12:58.671Z,1666217578.671 [ThrusterServo](ERROR): Communications Fault 2022-10-19T22:12:58.675Z,1666217578.675 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2022-10-19T22:12:59.024Z,1666217579.024 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2022-10-19T22:12:59.024Z,1666217579.024 [ThrusterServo](INFO): Powering down 2022-10-19T22:12:59.752Z,1666217579.752 [ThrusterServo](DEBUG): Initializing EZServoServo. 2022-10-19T22:12:59.872Z,1666217579.872 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2022-10-19T22:12:59.878Z,1666217579.878 [CBIT](INFO): Clearing failed state for component ThrusterServo 2022-10-19T22:12:59.879Z,1666217579.879 [ThrusterServo] No Fault, FailCount= 1 2022-10-19T22:13:19.248Z,1666217599.248 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:13:24.327Z,1666217604.327 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch -20.00 deg, mass-position 6.83 mm (1 active estimators). 2022-10-19T22:13:28.761Z,1666217608.761 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-19T22:13:54.387Z,1666217634.387 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:14:24.863Z,1666217664.863 [Radio_Surface](INFO): Powering down 2022-10-19T22:14:29.535Z,1666217669.535 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T22:14:30.540Z,1666217670.540 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T22:15:18.691Z,1666217718.691 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position 6.83 mm (2 active estimators). 2022-10-19T22:18:13.711Z,1666217893.711 [RudderServo](ERROR): getPosition uart error serial timeout 2022-10-19T22:18:13.711Z,1666217893.711 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout 2022-10-19T22:18:13.711Z,1666217893.711 [RudderServo] Communications Fault, FailCount= 1 2022-10-19T22:18:13.711Z,1666217893.711 [RudderServo](ERROR): Communications Fault 2022-10-19T22:18:13.760Z,1666217893.760 [CBIT](ERROR): Communications Fault in component: RudderServo 2022-10-19T22:18:14.008Z,1666217894.008 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2022-10-19T22:18:14.008Z,1666217894.008 [RudderServo](INFO): Powering down 2022-10-19T22:18:14.841Z,1666217894.841 [RudderServo](DEBUG): Initializing EZServoServo. 2022-10-19T22:18:14.960Z,1666217894.960 [RudderServo](DEBUG): Initializing RudderServo. 2022-10-19T22:18:14.992Z,1666217894.992 [CBIT](INFO): Clearing failed state for component RudderServo 2022-10-19T22:18:14.992Z,1666217894.992 [RudderServo] No Fault, FailCount= 1 2022-10-19T22:24:48.725Z,1666218288.725 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T22:39:58.934Z,1666219198.934 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T22:40:40.340Z,1666219240.340 [CTD_Seabird](ERROR): Failed to parse device response: .47 2022-10-19T22:46:04.969Z,1666219564.969 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T22:53:43.542Z,1666220023.542 [CTD_Seabird](ERROR): Failed to parse device response: 7,4.08127,3812.47 2022-10-19T23:01:51.200Z,1666220511.200 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2022-10-19T23:01:57.621Z,1666220517.621 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2022-10-19T23:01:57.623Z,1666220517.623 [BPC1](INFO): Received data from all battery sticks. 2022-10-19T23:03:16.798Z,1666220596.798 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-19T23:06:30.721Z,1666220790.721 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T23:08:05.745Z,1666220885.745 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2022-10-19T23:12:43.555Z,1666221163.555 [Radio_Surface](INFO): Powering up 2022-10-19T23:12:48.991Z,1666221168.991 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-19T23:12:49.615Z,1666221169.615 [Radio_Surface](INFO): Powering down 2022-10-19T23:13:19.111Z,1666221199.111 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:13:20.115Z,1666221200.115 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T23:13:24.027Z,1666221204.027 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-19T23:14:54.519Z,1666221294.519 [sci2:NeedComms] Running Loop=1 2022-10-19T23:14:54.519Z,1666221294.519 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-19T23:14:54.519Z,1666221294.519 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-19T23:14:54.519Z,1666221294.519 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-19T23:14:54.520Z,1666221294.520 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-19T23:14:54.520Z,1666221294.520 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-19T23:14:54.520Z,1666221294.520 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-19T23:14:54.521Z,1666221294.521 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-19T23:14:54.521Z,1666221294.521 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-19T23:14:54.521Z,1666221294.521 [sci2:NeedComms:A] Running Loop=1 2022-10-19T23:14:54.523Z,1666221294.523 [sci2:NeedComms:A](INFO): last time_fix was: 1666217575.000000 second since 1970/01/01T00:00:00Z 2022-10-19T23:14:54.523Z,1666221294.523 [sci2:NeedComms:A] Stopped 2022-10-19T23:17:18.351Z,1666221438.351 [sci2:NeedComms:C] Running Loop=1 2022-10-19T23:17:19.083Z,1666221439.083 [Radio_Surface](INFO): Powering up 2022-10-19T23:17:25.131Z,1666221445.131 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-19T23:17:30.047Z,1666221450.047 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T23:17:37.736Z,1666221457.736 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=21743, MT Status=1, MTMSN=1160 2022-10-19T23:17:37.736Z,1666221457.736 [NAL9602](INFO): Data available in MT queue 2022-10-19T23:17:38.215Z,1666221458.215 [NAL9602](INFO): Received command: schedule resume 2022-10-19T23:17:38.245Z,1666221458.245 [CommandExec](IMPORTANT): got command schedule resume 2022-10-19T23:17:38.245Z,1666221458.245 [CommandExec](IMPORTANT): Scheduling is resumed 2022-10-19T23:17:39.338Z,1666221459.338 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,231738.00,A,3621.34394,N,12204.24663,W,0.564,331.63,191022,,,A*75 2022-10-19T23:17:39.340Z,1666221459.340 [NAL9602](INFO): GPS fix at 20221019T231738: (36.355732, -122.070777) 2022-10-19T23:17:39.353Z,1666221459.353 [UniversalFixResidualReporter](INFO): Fix residual: 10.7 %DT, over the last 3843.1 m. Residual distance 410.6 m at bearing -56.2 degrees. Fix at (36.3557, -122.0708) with 2893.5 m made good. 2022-10-19T23:17:39.357Z,1666221459.357 [sci2:NeedComms:C] Stopped 2022-10-19T23:17:39.357Z,1666221459.357 [sci2:NeedComms:D] Running Loop=1 2022-10-19T23:17:54.700Z,1666221474.700 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=21744, MT Status=1, MTMSN=1161 2022-10-19T23:17:54.750Z,1666221474.750 [NAL9602](INFO): Sent 95 bytes from file Logs/20221019T173951/Courier0021.lzma 2022-10-19T23:17:54.750Z,1666221474.750 [NAL9602](INFO): Packets left to send: 0 2022-10-19T23:17:55.199Z,1666221475.199 [NAL9602](INFO): Received command: sched "ubat on;restart logs" 2022-10-19T23:17:55.217Z,1666221475.217 [CommandExec](IMPORTANT): got command schedule "ubat on;restart logs" 2022-10-19T23:17:55.218Z,1666221475.218 [CommandExec](IMPORTANT): Scheduled #10: "ubat on;restart logs", AFTER MISSION 2022-10-19T23:17:55.255Z,1666221475.255 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:18:17.453Z,1666221497.453 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=21745, MT Status=1, MTMSN=1162 2022-10-19T23:18:17.507Z,1666221497.507 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:18:17.507Z,1666221497.507 [NAL9602](INFO): Packets left to send: 9 2022-10-19T23:18:18.151Z,1666221498.151 [NAL9602](INFO): Received command: sched "load Science/sci2.tl;set sci2.MissionTimeout 14 h;set sci2.NeedCommsTime 120 min;set sci2.Lat1 36.696 degree;set sci2.Lon1 -121.9418 degree;set sci2.YoYoMaxDepth 50 m;set sci2.MaxDepth 75 m;run" 2022-10-19T23:18:18.243Z,1666221498.243 [CommandExec](IMPORTANT): got command schedule "load Science/sci2.tl;set sci2.MissionTimeout 14 h;set sci2.NeedCommsTime 120 min;set sci2.Lat1 36.696 degree;set sci2.Lon1 -121.9418 degree;set sci2.YoYoMaxDepth 50 m;set sci2.MaxDepth 75 m;run" 2022-10-19T23:18:18.244Z,1666221498.244 [CommandExec](IMPORTANT): Scheduled #11: "load Science/sci2.tl;set sci2.MissionTimeout 14 h;set sci2.NeedCommsTime 120 min;set sci2.Lat1 36.696 degree;set sci2.Lon1 -121.9418 degree;set sci2.YoYoMaxDepth 50 m;set sci2.MaxDepth 75 m;run", AFTER MISSION 2022-10-19T23:18:30.395Z,1666221510.395 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:18:31.106Z,1666221511.106 [NAL9602](INFO): SBD MO Status=1, MOMSN=21746, MT Status=0, MTMSN=0 2022-10-19T23:18:31.167Z,1666221511.167 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:18:31.167Z,1666221511.167 [NAL9602](INFO): Packets left to send: 8 2022-10-19T23:18:42.890Z,1666221522.890 [NAL9602](INFO): SBD MO Status=1, MOMSN=21747, MT Status=0, MTMSN=0 2022-10-19T23:18:42.947Z,1666221522.947 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:18:42.947Z,1666221522.947 [NAL9602](INFO): Packets left to send: 7 2022-10-19T23:18:53.105Z,1666221533.105 [NAL9602](INFO): SBD MO Status=1, MOMSN=21748, MT Status=0, MTMSN=0 2022-10-19T23:18:53.155Z,1666221533.155 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:18:53.155Z,1666221533.155 [NAL9602](INFO): Packets left to send: 6 2022-10-19T23:19:05.535Z,1666221545.535 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:19:06.086Z,1666221546.086 [NAL9602](INFO): SBD MO Status=1, MOMSN=21749, MT Status=0, MTMSN=0 2022-10-19T23:19:06.140Z,1666221546.140 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:19:06.140Z,1666221546.140 [NAL9602](INFO): Packets left to send: 5 2022-10-19T23:19:23.141Z,1666221563.141 [NAL9602](INFO): SBD MO Status=2, MOMSN=21750, MT Status=2, MTMSN=0 2022-10-19T23:19:23.142Z,1666221563.142 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T23:19:40.675Z,1666221580.675 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:20:03.606Z,1666221603.606 [NAL9602](INFO): SBD MO Status=2, MOMSN=21750, MT Status=2, MTMSN=0 2022-10-19T23:20:03.606Z,1666221603.606 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-19T23:20:15.823Z,1666221615.823 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:20:30.782Z,1666221630.782 [NAL9602](INFO): SBD MO Status=1, MOMSN=21750, MT Status=0, MTMSN=0 2022-10-19T23:20:30.831Z,1666221630.831 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:20:30.831Z,1666221630.831 [NAL9602](INFO): Packets left to send: 4 2022-10-19T23:20:50.971Z,1666221650.971 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:20:51.877Z,1666221651.877 [NAL9602](INFO): SBD MO Status=1, MOMSN=21751, MT Status=0, MTMSN=0 2022-10-19T23:20:51.935Z,1666221651.935 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:20:51.935Z,1666221651.935 [NAL9602](INFO): Packets left to send: 3 2022-10-19T23:21:05.740Z,1666221665.740 [NAL9602](INFO): SBD MO Status=1, MOMSN=21752, MT Status=0, MTMSN=0 2022-10-19T23:21:05.791Z,1666221665.791 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:21:05.791Z,1666221665.791 [NAL9602](INFO): Packets left to send: 2 2022-10-19T23:21:18.309Z,1666221678.309 [NAL9602](INFO): SBD MO Status=1, MOMSN=21753, MT Status=0, MTMSN=0 2022-10-19T23:21:18.363Z,1666221678.363 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:21:18.363Z,1666221678.363 [NAL9602](INFO): Packets left to send: 1 2022-10-19T23:21:26.112Z,1666221686.112 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:21:29.734Z,1666221689.734 [NAL9602](INFO): SBD MO Status=1, MOMSN=21754, MT Status=0, MTMSN=0 2022-10-19T23:21:29.787Z,1666221689.787 [NAL9602](INFO): Sent 140 bytes from file Logs/20221019T173951/Express0022.lzma 2022-10-19T23:21:29.787Z,1666221689.787 [NAL9602](INFO): Packets left to send: 0 2022-10-19T23:21:43.843Z,1666221703.843 [NAL9602](INFO): SBD MO Status=0, MOMSN=21755, MT Status=0, MTMSN=0 2022-10-19T23:22:00.900Z,1666221720.900 [NAL9602](INFO): SBD MO Status=1, MOMSN=21756, MT Status=0, MTMSN=0 2022-10-19T23:22:00.955Z,1666221720.955 [NAL9602](INFO): Sent 39 bytes from file Logs/20221019T173951/Courier0024.lzma 2022-10-19T23:22:00.955Z,1666221720.955 [NAL9602](INFO): Packets left to send: 0 2022-10-19T23:22:01.259Z,1666221721.259 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:22:12.682Z,1666221732.682 [NAL9602](INFO): SBD MO Status=1, MOMSN=21757, MT Status=0, MTMSN=0 2022-10-19T23:22:12.731Z,1666221732.731 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0025.lzma 2022-10-19T23:22:12.731Z,1666221732.731 [NAL9602](INFO): Packets left to send: 1 2022-10-19T23:22:18.453Z,1666221738.453 [NAL9602](INFO): SBD MO Status=1, MOMSN=21758, MT Status=0, MTMSN=0 2022-10-19T23:22:18.503Z,1666221738.503 [NAL9602](INFO): Sent 55 bytes from file Logs/20221019T173951/Express0025.lzma 2022-10-19T23:22:18.503Z,1666221738.503 [NAL9602](INFO): Packets left to send: 0 2022-10-19T23:22:26.943Z,1666221746.943 [NAL9602](INFO): SBD MO Status=0, MOMSN=21759, MT Status=0, MTMSN=0 2022-10-19T23:22:27.051Z,1666221747.051 [sci2:NeedComms:D] Stopped 2022-10-19T23:22:27.052Z,1666221747.052 [sci2:NeedComms:E] Running Loop=1 2022-10-19T23:22:29.362Z,1666221749.362 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,232228.00,A,3621.34724,N,12204.20626,W,1.458,85.43,191022,,,D*4C 2022-10-19T23:22:29.364Z,1666221749.364 [NAL9602](INFO): GPS fix at 20221019T232228: (36.355787, -122.070104) 2022-10-19T23:22:29.405Z,1666221749.405 [sci2:NeedComms:E] Stopped 2022-10-19T23:22:29.405Z,1666221749.405 [sci2:NeedComms](INFO): Completed sci2:NeedComms 2022-10-19T23:22:29.405Z,1666221749.405 [sci2:NeedComms] Stopped 2022-10-19T23:22:29.405Z,1666221749.405 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms 2022-10-19T23:22:29.406Z,1666221749.406 [sci2:NeedComms:B.GoToSurface] Stopped 2022-10-19T23:22:29.406Z,1666221749.406 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-19T23:22:36.399Z,1666221756.399 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:23:01.824Z,1666221781.824 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-19T23:23:11.545Z,1666221791.545 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:23:46.683Z,1666221826.683 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:23:52.271Z,1666221832.271 [Radio_Surface](INFO): Powering down 2022-10-19T23:24:21.835Z,1666221861.835 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-19T23:24:22.839Z,1666221862.839 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-19T23:25:33.791Z,1666221933.791 [RDI_Pathfinder](ERROR): only read -1 of 1 data item for altitude 2022-10-19T23:27:22.013Z,1666222042.013 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-19T23:27:31.780Z,1666222051.780 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-19T23:48:21.063Z,1666223301.063 [CBIT](IMPORTANT): Beginning ground fault scan 2022-10-19T23:48:22.025Z,1666223302.025 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:23.029Z,1666223303.029 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:24.033Z,1666223304.033 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:25.037Z,1666223305.037 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:26.041Z,1666223306.041 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:27.045Z,1666223307.045 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:28.049Z,1666223308.049 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:29.053Z,1666223309.053 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:30.057Z,1666223310.057 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:31.060Z,1666223311.060 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2022-10-19T23:48:31.862Z,1666223311.862 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.010340 CHAN A1 (24V): 0.000268 CHAN A2 (12V): -0.007288 CHAN A3 (5V): -0.002378 CHAN B0 (3.3V): 0.000588 CHAN B1 (3.15aV): 0.000198 CHAN B2 (3.15bV): 0.000448 CHAN B3 (GND): 0.001695 OPEN: 0.005495 Full Scale: +/- 1 mA 2022-10-19T23:50:13.215Z,1666223413.215 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-19T23:50:53.215Z,1666223453.215 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2022-10-19T23:55:35.211Z,1666223735.211 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-20T00:09:19.873Z,1666224559.873 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2022-10-20T00:09:26.693Z,1666224566.693 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2022-10-20T00:09:26.696Z,1666224566.696 [BPC1](INFO): Received data from all battery sticks. 2022-10-20T00:11:19.006Z,1666224679.006 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-20T00:11:29.114Z,1666224689.114 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2022-10-20T00:11:39.214Z,1666224699.214 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-20T00:20:08.948Z,1666225208.948 [CTD_Seabird](ERROR): Failed to parse device response: .70 2022-10-20T00:24:15.549Z,1666225455.549 [sci2:NeedComms] Running Loop=1 2022-10-20T00:24:15.549Z,1666225455.549 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-20T00:24:15.549Z,1666225455.549 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-20T00:24:15.549Z,1666225455.549 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-20T00:24:15.550Z,1666225455.550 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-20T00:24:15.550Z,1666225455.550 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-20T00:24:15.550Z,1666225455.550 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-20T00:24:15.567Z,1666225455.567 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-20T00:24:15.567Z,1666225455.567 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-20T00:24:15.568Z,1666225455.568 [sci2:NeedComms:A] Running Loop=1 2022-10-20T00:24:15.569Z,1666225455.569 [sci2:NeedComms:A](INFO): last time_fix was: 1666221748.000000 second since 1970/01/01T00:00:00Z 2022-10-20T00:24:15.569Z,1666225455.569 [sci2:NeedComms:A] Stopped 2022-10-20T00:26:35.334Z,1666225595.334 [sci2:NeedComms:C] Running Loop=1 2022-10-20T00:26:36.023Z,1666225596.023 [Radio_Surface](INFO): Powering up 2022-10-20T00:26:42.228Z,1666225602.228 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-20T00:27:22.994Z,1666225642.994 [NAL9602](INFO): SBD MO Status=2, MOMSN=21760, MT Status=2, MTMSN=0 2022-10-20T00:27:22.994Z,1666225642.994 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-20T00:27:31.877Z,1666225651.877 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=21760, MT Status=1, MTMSN=1163 2022-10-20T00:27:31.878Z,1666225651.878 [NAL9602](INFO): Data available in MT queue 2022-10-20T00:27:32.363Z,1666225652.363 [NAL9602](INFO): Received command: schedule list 2022-10-20T00:27:32.461Z,1666225652.461 [CommandExec](IMPORTANT): got command schedule list 2022-10-20T00:27:32.461Z,1666225652.461 [CommandExec](IMPORTANT): Scheduled #7 (#2 of 2 with id='4clw7'): "set sci2.MaxDepth 110 m;run", ASAP 2022-10-20T00:27:32.462Z,1666225652.462 [CommandExec](IMPORTANT): Scheduled #10: "ubat on;restart logs", AFTER MISSION 2022-10-20T00:27:32.462Z,1666225652.462 [CommandExec](IMPORTANT): Scheduled #11: "load Science/sci2.tl;set sci2.MissionTimeout 14 h;set sci2.NeedCommsTime 120 min;set sci2.Lat1 36.696 degree;set sci2.Lon1 -121.9418 degree;set sci2.YoYoMaxDepth 50 m;set sci2.MaxDepth 75 m;run", AFTER MISSION 2022-10-20T00:27:33.490Z,1666225653.490 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,002732.00,A,3621.96443,N,12205.80530,W,1.166,122.84,201022,,,D*73 2022-10-20T00:27:33.492Z,1666225653.492 [NAL9602](INFO): GPS fix at 20221020T002732: (36.366074, -122.096755) 2022-10-20T00:27:33.528Z,1666225653.528 [UniversalFixResidualReporter](INFO): Fix residual: 30.3 %DT, over the last 3804.6 m. Residual distance 1153.0 m at bearing -83.6 degrees. Fix at (36.3661, -122.0968) with 2646.4 m made good. 2022-10-20T00:27:33.539Z,1666225653.539 [sci2:NeedComms:C] Stopped 2022-10-20T00:27:33.539Z,1666225653.539 [sci2:NeedComms:D] Running Loop=1 2022-10-20T00:27:51.398Z,1666225671.398 [NAL9602](INFO): SBD MO Status=1, MOMSN=21761, MT Status=0, MTMSN=0 2022-10-20T00:27:51.459Z,1666225671.459 [NAL9602](INFO): Sent 95 bytes from file Logs/20221019T173951/Courier0027.lzma 2022-10-20T00:27:51.459Z,1666225671.459 [NAL9602](INFO): Packets left to send: 0 2022-10-20T00:28:01.987Z,1666225681.987 [NAL9602](INFO): SBD MO Status=1, MOMSN=21762, MT Status=0, MTMSN=0 2022-10-20T00:28:02.039Z,1666225682.039 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:28:02.039Z,1666225682.039 [NAL9602](INFO): Packets left to send: 10 2022-10-20T00:28:17.016Z,1666225697.016 [NAL9602](INFO): SBD MO Status=1, MOMSN=21763, MT Status=0, MTMSN=0 2022-10-20T00:28:17.075Z,1666225697.075 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:28:17.075Z,1666225697.075 [NAL9602](INFO): Packets left to send: 9 2022-10-20T00:28:28.830Z,1666225708.830 [NAL9602](INFO): SBD MO Status=1, MOMSN=21764, MT Status=0, MTMSN=0 2022-10-20T00:28:28.879Z,1666225708.879 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:28:28.879Z,1666225708.879 [NAL9602](INFO): Packets left to send: 8 2022-10-20T00:28:47.882Z,1666225727.882 [NAL9602](INFO): SBD MO Status=2, MOMSN=21765, MT Status=2, MTMSN=0 2022-10-20T00:28:47.882Z,1666225727.882 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-20T00:29:07.375Z,1666225747.375 [NAL9602](INFO): SBD MO Status=1, MOMSN=21765, MT Status=0, MTMSN=0 2022-10-20T00:29:07.425Z,1666225747.425 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:29:07.425Z,1666225747.425 [NAL9602](INFO): Packets left to send: 7 2022-10-20T00:29:19.953Z,1666225759.953 [NAL9602](INFO): SBD MO Status=1, MOMSN=21766, MT Status=0, MTMSN=0 2022-10-20T00:29:20.007Z,1666225760.007 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:29:20.008Z,1666225760.008 [NAL9602](INFO): Packets left to send: 6 2022-10-20T00:29:29.903Z,1666225769.903 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:29:43.062Z,1666225783.062 [NAL9602](INFO): SBD MO Status=1, MOMSN=21767, MT Status=0, MTMSN=0 2022-10-20T00:29:43.123Z,1666225783.123 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:29:43.123Z,1666225783.123 [NAL9602](INFO): Packets left to send: 5 2022-10-20T00:29:55.657Z,1666225795.657 [NAL9602](INFO): SBD MO Status=1, MOMSN=21768, MT Status=0, MTMSN=0 2022-10-20T00:29:55.711Z,1666225795.711 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:29:55.711Z,1666225795.711 [NAL9602](INFO): Packets left to send: 4 2022-10-20T00:30:05.043Z,1666225805.043 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:30:19.719Z,1666225819.719 [NAL9602](INFO): SBD MO Status=1, MOMSN=21769, MT Status=0, MTMSN=0 2022-10-20T00:30:19.775Z,1666225819.775 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:30:19.775Z,1666225819.775 [NAL9602](INFO): Packets left to send: 3 2022-10-20T00:30:40.187Z,1666225840.187 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:31:01.082Z,1666225861.082 [NAL9602](INFO): SBD MO Status=2, MOMSN=21770, MT Status=2, MTMSN=0 2022-10-20T00:31:01.082Z,1666225861.082 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-20T00:31:15.327Z,1666225875.327 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:31:36.308Z,1666225896.308 [NAL9602](INFO): SBD MO Status=1, MOMSN=21770, MT Status=0, MTMSN=0 2022-10-20T00:31:36.367Z,1666225896.367 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:31:36.367Z,1666225896.367 [NAL9602](INFO): Packets left to send: 2 2022-10-20T00:31:50.467Z,1666225910.467 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:31:51.748Z,1666225911.748 [NAL9602](INFO): SBD MO Status=2, MOMSN=21771, MT Status=2, MTMSN=0 2022-10-20T00:31:51.748Z,1666225911.748 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-20T00:32:25.619Z,1666225945.619 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:32:32.657Z,1666225952.657 [NAL9602](INFO): SBD MO Status=1, MOMSN=21771, MT Status=0, MTMSN=0 2022-10-20T00:32:32.707Z,1666225952.707 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:32:32.707Z,1666225952.707 [NAL9602](INFO): Packets left to send: 1 2022-10-20T00:32:53.770Z,1666225973.770 [NAL9602](INFO): SBD MO Status=1, MOMSN=21772, MT Status=0, MTMSN=0 2022-10-20T00:32:53.827Z,1666225973.827 [NAL9602](INFO): Sent 65 bytes from file Logs/20221019T173951/Express0028.lzma 2022-10-20T00:32:53.827Z,1666225973.827 [NAL9602](INFO): Packets left to send: 0 2022-10-20T00:33:00.767Z,1666225980.767 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:33:04.673Z,1666225984.673 [NAL9602](INFO): SBD MO Status=0, MOMSN=21773, MT Status=0, MTMSN=0 2022-10-20T00:33:14.039Z,1666225994.039 [NAL9602](INFO): SBD MO Status=1, MOMSN=21774, MT Status=0, MTMSN=0 2022-10-20T00:33:14.091Z,1666225994.091 [NAL9602](INFO): Sent 39 bytes from file Logs/20221019T173951/Courier0030.lzma 2022-10-20T00:33:14.091Z,1666225994.091 [NAL9602](INFO): Packets left to send: 0 2022-10-20T00:33:34.402Z,1666226014.402 [NAL9602](INFO): SBD MO Status=1, MOMSN=21775, MT Status=0, MTMSN=0 2022-10-20T00:33:34.455Z,1666226014.455 [NAL9602](INFO): Sent 117 bytes from file Logs/20221019T173951/Express0031.lzma 2022-10-20T00:33:34.455Z,1666226014.455 [NAL9602](INFO): Packets left to send: 0 2022-10-20T00:33:35.907Z,1666226015.907 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:33:52.578Z,1666226032.578 [NAL9602](INFO): SBD MO Status=0, MOMSN=21776, MT Status=0, MTMSN=0 2022-10-20T00:33:52.659Z,1666226032.659 [sci2:NeedComms:D] Stopped 2022-10-20T00:33:52.660Z,1666226032.660 [sci2:NeedComms:E] Running Loop=1 2022-10-20T00:33:55.005Z,1666226035.005 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,003353.00,A,3621.91802,N,12205.70253,W,0.544,112.72,201022,,,D*7D 2022-10-20T00:33:55.008Z,1666226035.008 [NAL9602](INFO): GPS fix at 20221020T003353: (36.365300, -122.095042) 2022-10-20T00:33:55.092Z,1666226035.092 [sci2:NeedComms:E] Stopped 2022-10-20T00:33:55.092Z,1666226035.092 [sci2:NeedComms](INFO): Completed sci2:NeedComms 2022-10-20T00:33:55.092Z,1666226035.092 [sci2:NeedComms] Stopped 2022-10-20T00:33:55.092Z,1666226035.092 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms 2022-10-20T00:33:55.093Z,1666226035.093 [sci2:NeedComms:B.GoToSurface] Stopped 2022-10-20T00:33:55.093Z,1666226035.093 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2022-10-20T00:34:11.051Z,1666226051.051 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:34:27.331Z,1666226067.331 [NAL9602](INFO): Not Powering down - fast GPS 2022-10-20T00:34:46.191Z,1666226086.191 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:35:21.331Z,1666226121.331 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:35:39.531Z,1666226139.531 [Radio_Surface](INFO): Powering down 2022-10-20T00:35:56.484Z,1666226156.484 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T00:35:57.487Z,1666226157.487 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2022-10-20T00:37:30.332Z,1666226250.332 [CTD_Seabird](ERROR): Failed to parse device response: 96,3991.09 2022-10-20T00:52:01.045Z,1666227121.045 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-20T00:58:31.315Z,1666227511.315 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2022-10-20T01:05:57.342Z,1666227957.342 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2022-10-20T01:09:02.369Z,1666228142.369 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-20T01:13:52.121Z,1666228432.121 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-20T01:14:12.305Z,1666228452.305 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2022-10-20T01:16:55.916Z,1666228615.916 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2022-10-20T01:16:55.918Z,1666228615.918 [BPC1](INFO): Received data from all battery sticks. 2022-10-20T01:32:17.942Z,1666229537.942 [CTD_Seabird](ERROR): Failed to parse device response: 0 2022-10-20T01:35:23.299Z,1666229723.299 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-20T01:35:33.380Z,1666229733.380 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-20T01:35:51.208Z,1666229751.208 [sci2:NeedComms] Running Loop=1 2022-10-20T01:35:51.208Z,1666229751.208 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms 2022-10-20T01:35:51.208Z,1666229751.208 [sci2:NeedComms:B.GoToSurface] Running Loop=1 2022-10-20T01:35:51.208Z,1666229751.208 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2022-10-20T01:35:51.209Z,1666229751.209 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2022-10-20T01:35:51.209Z,1666229751.209 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2022-10-20T01:35:51.209Z,1666229751.209 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2022-10-20T01:35:51.210Z,1666229751.210 [sci2:NeedComms:B.GoToSurface](INFO): Received surface timeout setting 1000.000000 seconds. 2022-10-20T01:35:51.210Z,1666229751.210 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2022-10-20T01:35:51.210Z,1666229751.210 [sci2:NeedComms:A] Running Loop=1 2022-10-20T01:35:51.212Z,1666229751.212 [sci2:NeedComms:A](INFO): last time_fix was: 1666226033.000000 second since 1970/01/01T00:00:00Z 2022-10-20T01:35:51.212Z,1666229751.212 [sci2:NeedComms:A] Stopped 2022-10-20T01:35:53.221Z,1666229753.221 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-20T01:36:03.297Z,1666229763.297 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-20T01:36:23.497Z,1666229783.497 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2022-10-20T01:37:08.388Z,1666229828.388 [sci2:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.00 2022-10-20T01:37:08.739Z,1666229828.739 [sci2:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.00 2022-10-20T01:37:08.963Z,1666229828.963 [Radio_Surface](INFO): Powering up 2022-10-20T01:37:09.166Z,1666229829.166 [sci2:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.00 2022-10-20T01:37:09.563Z,1666229829.563 [sci2:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.00 2022-10-20T01:37:09.946Z,1666229829.946 [sci2:NeedComms:B.GoToSurface](ERROR): Altitude too low: 0.00 2022-10-20T01:37:15.023Z,1666229835.023 [Radio_Surface](INFO): Powering down 2022-10-20T01:38:13.392Z,1666229893.392 [sci2:NeedComms:C] Running Loop=1 2022-10-20T01:38:14.011Z,1666229894.011 [Radio_Surface](INFO): Powering up 2022-10-20T01:38:20.092Z,1666229900.092 [DataOverHttps](INFO): Radio surface powered ON. 2022-10-20T01:38:26.694Z,1666229906.694 [NAL9602](INFO): SBD MO Status=0, MOMSN=21777, MT Status=0, MTMSN=0 2022-10-20T01:38:26.694Z,1666229906.694 [NAL9602](INFO): No messages in MT queue 2022-10-20T01:38:27.916Z,1666229907.916 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,013826.99,A,3622.19593,N,12207.18846,W,0.330,15.08,201022,,,A*4A 2022-10-20T01:38:27.918Z,1666229907.918 [NAL9602](INFO): GPS fix at 20221020T013826: (36.369932, -122.119808) 2022-10-20T01:38:27.932Z,1666229907.932 [UniversalFixResidualReporter](INFO): Fix residual: 28.9 %DT, over the last 3877.8 m. Residual distance 1120.3 m at bearing -71.0 degrees. Fix at (36.3699, -122.1198) with 2276.5 m made good. 2022-10-20T01:38:27.936Z,1666229907.936 [sci2:NeedComms:C] Stopped 2022-10-20T01:38:27.936Z,1666229907.936 [sci2:NeedComms:D] Running Loop=1 2022-10-20T01:38:37.926Z,1666229917.926 [NAL9602](INFO): SBD MO Status=1, MOMSN=21778, MT Status=0, MTMSN=0 2022-10-20T01:38:37.975Z,1666229917.975 [NAL9602](INFO): Sent 95 bytes from file Logs/20221019T173951/Courier0033.lzma 2022-10-20T01:38:37.975Z,1666229917.975 [NAL9602](INFO): Packets left to send: 0 2022-10-20T01:38:50.212Z,1666229930.212 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T01:38:52.689Z,1666229932.689 [NAL9602](INFO): SBD MO Status=1, MOMSN=21779, MT Status=0, MTMSN=0 2022-10-20T01:38:52.751Z,1666229932.751 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0034.lzma 2022-10-20T01:38:52.751Z,1666229932.751 [NAL9602](INFO): Packets left to send: 8 2022-10-20T01:38:56.668Z,1666229936.668 [CTD_Seabird](ERROR): Failed to parse device response: .81 2022-10-20T01:39:06.604Z,1666229946.604 [NAL9602](INFO): SBD MO Status=1, MOMSN=21780, MT Status=0, MTMSN=0 2022-10-20T01:39:06.659Z,1666229946.659 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0034.lzma 2022-10-20T01:39:06.659Z,1666229946.659 [NAL9602](INFO): Packets left to send: 7 2022-10-20T01:39:24.571Z,1666229964.571 [NAL9602](INFO): SBD MO Status=1, MOMSN=21781, MT Status=0, MTMSN=0 2022-10-20T01:39:24.621Z,1666229964.621 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0034.lzma 2022-10-20T01:39:24.621Z,1666229964.621 [NAL9602](INFO): Packets left to send: 6 2022-10-20T01:39:25.371Z,1666229965.371 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T01:39:42.401Z,1666229982.401 [NAL9602](INFO): SBD MO Status=2, MOMSN=21782, MT Status=2, MTMSN=0 2022-10-20T01:39:42.401Z,1666229982.401 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-20T01:40:00.519Z,1666230000.519 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T01:40:08.361Z,1666230008.361 [NAL9602](INFO): SBD MO Status=2, MOMSN=21782, MT Status=2, MTMSN=0 2022-10-20T01:40:08.361Z,1666230008.361 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2022-10-20T01:40:16.512Z,1666230016.512 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2022-10-20T01:40:17.012Z,1666230017.012 [CTD_Seabird](ERROR): Failed to parse device response: 9 2022-10-20T01:40:31.058Z,1666230031.058 [NAL9602](INFO): SBD MO Status=1, MOMSN=21782, MT Status=0, MTMSN=0 2022-10-20T01:40:31.107Z,1666230031.107 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0034.lzma 2022-10-20T01:40:31.107Z,1666230031.107 [NAL9602](INFO): Packets left to send: 5 2022-10-20T01:40:35.676Z,1666230035.676 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T01:40:41.661Z,1666230041.661 [NAL9602](INFO): SBD MO Status=1, MOMSN=21783, MT Status=0, MTMSN=0 2022-10-20T01:40:41.719Z,1666230041.719 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0034.lzma 2022-10-20T01:40:41.719Z,1666230041.719 [NAL9602](INFO): Packets left to send: 4 2022-10-20T01:40:58.766Z,1666230058.766 [NAL9602](INFO): SBD MO Status=1, MOMSN=21784, MT Status=0, MTMSN=0 2022-10-20T01:40:58.825Z,1666230058.825 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0034.lzma 2022-10-20T01:40:58.826Z,1666230058.826 [NAL9602](INFO): Packets left to send: 3 2022-10-20T01:41:09.733Z,1666230069.733 [NAL9602](INFO): SBD MO Status=1, MOMSN=21785, MT Status=0, MTMSN=0 2022-10-20T01:41:09.783Z,1666230069.783 [NAL9602](INFO): Sent 332 bytes from file Logs/20221019T173951/Express0034.lzma 2022-10-20T01:41:09.783Z,1666230069.783 [NAL9602](INFO): Packets left to send: 2 2022-10-20T01:41:10.823Z,1666230070.823 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2022-10-20T01:41:16.748Z,1666230076.748 [sci2](INFO): Timed out from 2022-10-19T17:41:16.4Z 2022-10-20T01:41:16.748Z,1666230076.748 [MissionManager](INFO): sci2 is completed.