2021-08-15T05:14:48.360Z,1629004488.360 [CommandLine](IMPORTANT): got command restart logs 2021-08-15T05:14:48.934Z,1629004488.934 [Micromodem](INFO): Nmea in: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error 2021-08-15T05:14:48.934Z,1629004488.934 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error expected 41 2021-08-15T05:14:48.940Z,1629004488.940 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T05:14:49.315Z,1629004489.315 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815051448.119441,06,902,23,0092,0150,149,01,01,01,01,-1,-01,-01,1,3,3,0,150,63.4,5.90,-100,-2.90,-01,0.20,-6,14500,4000*76 2021-08-15T05:15:24.482Z,1629004524.482 [DataOverHttps](IMPORTANT): SBD MTMSN=20210815T051525 2021-08-15T05:15:28.501Z,1629004528.501 [DataOverHttps](INFO): Received command:sched asap "load Science/profile_station.xml;set profile_station.MissionTimeout 480 min;set profile_station.NeedCommsTime 180 min;set profile_station.Lat 41.55311 degree;set profile_station.Lon -70.70716 degree" 2sela 1 3 2021-08-15T05:15:28.514Z,1629004528.514 [CommandLine](IMPORTANT): got command schedule asap "load Science/profile_station.xml;set profile_station.MissionTimeout 480 min;set profile_station.NeedCommsTime 180 min;set profile_station.Lat 41.55311 degree;set profile_station.Lon -70.70716 degree" 2sela 1 3.000000 2021-08-15T05:15:28.514Z,1629004528.514 [CommandLine](IMPORTANT): Scheduling command #1 of 3 with id=2sela 2021-08-15T05:15:28.515Z,1629004528.515 [CommandLine](IMPORTANT): Scheduled #24 (#1 of 3 with id='2sela'): "load Science/profile_station.xml;set profile_station.MissionTimeout 480 min;set profile_station.NeedCommsTime 180 min;set profile_station.Lat 41.55311 degree;set profile_station.Lon -70.70716 degree" ASAP 2021-08-15T05:15:29.502Z,1629004529.502 [DataOverHttps](IMPORTANT): SBD MTMSN=20210815T051530 2021-08-15T05:15:31.723Z,1629004531.723 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T05:15:31.728Z,1629004531.728 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815051532.127813,06,1099,24,0109,0150,194,02,02,01,02,-1,-01,-01,1,3,4,0,150,8.4,-0.23,-100,3.23,-01,0.62,64,14500,4000*60 2021-08-15T05:15:33.520Z,1629004533.520 [DataOverHttps](INFO): Received command:sched asap "set profile_station.YoYoMinDepth 3 m;set profile_station.YoYoMaxDepth 7 m;set profile_station.YoYoMinAltitude 3 m;set profile_station.YoYoPitch 15 degree;set profile_station.MinAltitude 3 m;set profile_station.MaxDepth 9 m" 2sela 2 3 2021-08-15T05:15:33.529Z,1629004533.529 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.YoYoMinDepth 3 m;set profile_station.YoYoMaxDepth 7 m;set profile_station.YoYoMinAltitude 3 m;set profile_station.YoYoPitch 15 degree;set profile_station.MinAltitude 3 m;set profile_station.MaxDepth 9 m" 2sela 2 3.000000 2021-08-15T05:15:33.529Z,1629004533.529 [CommandLine](IMPORTANT): Scheduling command #2 of 3 with id=2sela 2021-08-15T05:15:33.530Z,1629004533.530 [CommandLine](IMPORTANT): Scheduled #25 (#2 of 3 with id='2sela'): "set profile_station.YoYoMinDepth 3 m;set profile_station.YoYoMaxDepth 7 m;set profile_station.YoYoMinAltitude 3 m;set profile_station.YoYoPitch 15 degree;set profile_station.MinAltitude 3 m;set profile_station.MaxDepth 9 m" ASAP 2021-08-15T05:15:34.522Z,1629004534.522 [DataOverHttps](IMPORTANT): SBD MTMSN=20210815T051535 2021-08-15T05:15:38.540Z,1629004538.540 [DataOverHttps](INFO): Received command:sched asap "set profile_station.MinOffshore 500 m;run" 2sela 3 3 2021-08-15T05:15:38.577Z,1629004538.577 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.MinOffshore 500 m;run" 2sela 3 3.000000 2021-08-15T05:15:38.578Z,1629004538.578 [CommandLine](IMPORTANT): Scheduling command #3 of 3 with id=2sela 2021-08-15T05:15:38.579Z,1629004538.579 [CommandLine](IMPORTANT): Scheduled #26 (#3 of 3 with id='2sela'): "set profile_station.MinOffshore 500 m;run" ASAP 2021-08-15T05:15:38.684Z,1629004538.684 [CommandLine](IMPORTANT): got command load ./Missions/Science/profile_station.xml 2021-08-15T05:15:38.685Z,1629004538.685 [MissionManager](INFO): Loading Mission: ./Missions/Science/profile_station.xml 2021-08-15T05:15:38.872Z,1629004538.872 [MissionManager](INFO): DefineArg profile_station.MissionTimeout = 4.000000 h 2021-08-15T05:15:38.874Z,1629004538.874 [MissionManager](INFO): DefineArg profile_station.NeedCommsTime = 60.000000 min 2021-08-15T05:15:38.877Z,1629004538.877 [MissionManager](INFO): DefineArg profile_station.Lat = 36.806966 arcdeg 2021-08-15T05:15:38.879Z,1629004538.879 [MissionManager](INFO): DefineArg profile_station.Lon = -121.824326 arcdeg 2021-08-15T05:15:38.882Z,1629004538.882 [MissionManager](INFO): DefineArg profile_station.Radius = 300.000000 m 2021-08-15T05:15:38.885Z,1629004538.885 [MissionManager](INFO): DefineArg profile_station.YoYoMinDepth = 2.000000 m 2021-08-15T05:15:38.887Z,1629004538.887 [MissionManager](INFO): DefineArg profile_station.YoYoMaxDepth = 200.000000 m 2021-08-15T05:15:38.889Z,1629004538.889 [MissionManager](INFO): DefineArg profile_station.YoYoMinAltitude = 7.000000 m 2021-08-15T05:15:38.892Z,1629004538.892 [MissionManager](INFO): DefineArg profile_station.YoYoPitch = 20.000000 arcdeg 2021-08-15T05:15:38.894Z,1629004538.894 [MissionManager](INFO): DefineArg profile_station.Speed = 1.000000 m/s 2021-08-15T05:15:38.897Z,1629004538.897 [MissionManager](INFO): DefineArg profile_station.CircleMaxError = 100.000000 m 2021-08-15T05:15:38.899Z,1629004538.899 [MissionManager](INFO): DefineArg profile_station.CircleTurnToPort = 0 bool 2021-08-15T05:15:38.902Z,1629004538.902 [MissionManager](INFO): DefineArg profile_station.KwpHeading = 0.010000 rad/m 2021-08-15T05:15:38.905Z,1629004538.905 [MissionManager](INFO): DefineArg profile_station.MinAltitude = 5.000000 m 2021-08-15T05:15:38.907Z,1629004538.907 [MissionManager](INFO): DefineArg profile_station.MaxDepth = 205.000000 m 2021-08-15T05:15:38.934Z,1629004538.934 [MissionManager](INFO): DefineArg profile_station.MinOffshore = 2.000000 km 2021-08-15T05:15:38.934Z,1629004538.934 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml 2021-08-15T05:15:39.323Z,1629004539.323 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectChlActive = 0 bool 2021-08-15T05:15:39.326Z,1629004539.326 [MissionManager](INFO): DefineArg profile_station:Science.TimeWindowPeakReport = nan min 2021-08-15T05:15:39.328Z,1629004539.328 [MissionManager](INFO): DefineArg profile_station:Science.HighestChlPeakReportActive = 0 bool 2021-08-15T05:15:39.330Z,1629004539.330 [MissionManager](INFO): DefineArg profile_station:Science.HighestSaltPeakReportActive = 0 bool 2021-08-15T05:15:39.332Z,1629004539.332 [MissionManager](INFO): DefineArg profile_station:Science.HighestOilPeakReportActive = 0 bool 2021-08-15T05:15:39.334Z,1629004539.334 [MissionManager](INFO): DefineArg profile_station:Science.PatchTracking = 0 bool 2021-08-15T05:15:39.358Z,1629004539.358 [MissionManager](INFO): DefineArg profile_station:Science.FilterWidthHorizontal = 3.000000 count 2021-08-15T05:15:39.364Z,1629004539.364 [MissionManager](INFO): DefineArg profile_station:Science.NumProfilesSlidingwindow = 100.000000 count 2021-08-15T05:15:39.367Z,1629004539.367 [MissionManager](INFO): DefineArg profile_station:Science.OffPeakFractionHorizontal = 80.000000 % 2021-08-15T05:15:39.414Z,1629004539.414 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectNO3Active = 0 bool 2021-08-15T05:15:39.420Z,1629004539.420 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectOilActive = 0 bool 2021-08-15T05:15:39.422Z,1629004539.422 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectFDOMActive = 0 bool 2021-08-15T05:15:39.433Z,1629004539.433 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectSalinityActive = 0 bool 2021-08-15T05:15:39.435Z,1629004539.435 [MissionManager](INFO): DefineArg profile_station:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2021-08-15T05:15:39.452Z,1629004539.452 [MissionManager](INFO): DefineArg profile_station:Science.EnabledAanderaaO2 = 0.000000 bool 2021-08-15T05:15:39.455Z,1629004539.455 [MissionManager](INFO): DefineArg profile_station:Science.EnabledNeilBrown = 0.000000 bool 2021-08-15T05:15:39.462Z,1629004539.462 [MissionManager](INFO): DefineArg profile_station:Science.EnabledSeabird = 1.000000 bool 2021-08-15T05:15:39.468Z,1629004539.468 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsBB2FL = 0.000000 bool 2021-08-15T05:15:39.471Z,1629004539.471 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsSeaOWL_UV_A = 1.000000 bool 2021-08-15T05:15:39.478Z,1629004539.478 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsUBAT = 0.000000 bool 2021-08-15T05:15:39.484Z,1629004539.484 [MissionManager](INFO): DefineArg profile_station:Science.LowPassWindowLength = 20.000000 count 2021-08-15T05:15:39.487Z,1629004539.487 [MissionManager](INFO): DefineArg profile_station:Science.MedianFilterLen = 5.000000 count 2021-08-15T05:15:39.493Z,1629004539.493 [MissionManager](INFO): DefineArg profile_station:Science.PeakShallowBound = nan m 2021-08-15T05:15:39.495Z,1629004539.495 [MissionManager](INFO): DefineArg profile_station:Science.PeakDeepBound = nan m 2021-08-15T05:15:39.506Z,1629004539.506 [MissionManager](INFO): DefineArg profile_station:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2021-08-15T05:15:39.511Z,1629004539.511 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChl = 0.000000 ug/l 2021-08-15T05:15:39.534Z,1629004539.534 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlDepth = 0.000000 m 2021-08-15T05:15:39.545Z,1629004539.545 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlTemperature = 0.000000 degC 2021-08-15T05:15:39.547Z,1629004539.547 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLatitude = nan arcdeg 2021-08-15T05:15:39.554Z,1629004539.554 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLongitude = nan arcdeg 2021-08-15T05:15:39.565Z,1629004539.565 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3 = 0.000000 umol/l 2021-08-15T05:15:39.567Z,1629004539.567 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Depth = 0.000000 m 2021-08-15T05:15:39.574Z,1629004539.574 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Latitude = nan arcdeg 2021-08-15T05:15:39.589Z,1629004539.589 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Longitude = nan arcdeg 2021-08-15T05:15:39.591Z,1629004539.591 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOil = 0.000000 kg/m3 2021-08-15T05:15:39.601Z,1629004539.601 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilDepth = 0.000000 m 2021-08-15T05:15:39.609Z,1629004539.609 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLatitude = nan arcdeg 2021-08-15T05:15:39.611Z,1629004539.611 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLongitude = nan arcdeg 2021-08-15T05:15:39.618Z,1629004539.618 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOM = 0.000000 ppb 2021-08-15T05:15:39.625Z,1629004539.625 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMDepth = 0.000000 m 2021-08-15T05:15:39.627Z,1629004539.627 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMTemperature = nan degC 2021-08-15T05:15:39.631Z,1629004539.631 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLatitude = nan arcdeg 2021-08-15T05:15:39.642Z,1629004539.642 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLongitude = nan arcdeg 2021-08-15T05:15:39.646Z,1629004539.646 [MissionManager](INFO): DefineOutput profile_station:Science.PatchFDOMDistance = nan m 2021-08-15T05:15:39.656Z,1629004539.656 [MissionManager](INFO): DefineOutput profile_station:Science.PeakSalt = 0.000000 psu 2021-08-15T05:15:39.659Z,1629004539.659 [MissionManager](INFO): DefineOutput profile_station:Science.PeakSaltDepth = 0.000000 m 2021-08-15T05:15:39.670Z,1629004539.670 [MissionManager](INFO): DefineOutput profile_station:Science.PeakSaltTemperature = 0.000000 degC 2021-08-15T05:15:39.681Z,1629004539.681 [MissionManager](INFO): DefineOutput profile_station:Science.PeakSaltLatitude = nan arcdeg 2021-08-15T05:15:39.683Z,1629004539.683 [MissionManager](INFO): DefineOutput profile_station:Science.PeakSaltLongitude = nan arcdeg 2021-08-15T05:15:39.694Z,1629004539.694 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChl = 0.000000 ug/l 2021-08-15T05:15:39.701Z,1629004539.701 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDepth = 0.000000 m 2021-08-15T05:15:39.703Z,1629004539.703 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLatitude = nan arcdeg 2021-08-15T05:15:39.710Z,1629004539.710 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLongitude = nan arcdeg 2021-08-15T05:15:39.717Z,1629004539.717 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDistance = nan m 2021-08-15T05:15:39.719Z,1629004539.719 [MissionManager](INFO): DefineOutput profile_station:Science.PatchSalt = 0.000000 psu 2021-08-15T05:15:39.726Z,1629004539.726 [MissionManager](INFO): DefineOutput profile_station:Science.PatchSaltDepth = 0.000000 m 2021-08-15T05:15:39.731Z,1629004539.731 [MissionManager](INFO): DefineOutput profile_station:Science.PatchSaltLatitude = nan arcdeg 2021-08-15T05:15:39.744Z,1629004539.744 [MissionManager](INFO): DefineOutput profile_station:Science.PatchSaltLongitude = nan arcdeg 2021-08-15T05:15:39.747Z,1629004539.747 [MissionManager](INFO): DefineOutput profile_station:Science.PatchSaltDistance = nan m 2021-08-15T05:15:39.749Z,1629004539.749 [MissionManager](INFO): DefineOutput profile_station:Science.PatchOil = 0.000000 psu 2021-08-15T05:15:39.767Z,1629004539.767 [MissionManager](INFO): DefineOutput profile_station:Science.PatchOilDepth = 0.000000 m 2021-08-15T05:15:39.769Z,1629004539.769 [MissionManager](INFO): DefineOutput profile_station:Science.PatchOilLatitude = nan arcdeg 2021-08-15T05:15:39.772Z,1629004539.772 [MissionManager](INFO): DefineOutput profile_station:Science.PatchOilLongitude = nan arcdeg 2021-08-15T05:15:39.774Z,1629004539.774 [MissionManager](INFO): DefineOutput profile_station:Science.PatchOilDistance = nan m 2021-08-15T05:15:39.907Z,1629004539.907 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-08-15T05:15:39.960Z,1629004539.960 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-08-15T05:15:39.985Z,1629004539.985 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-08-15T05:15:40.016Z,1629004540.016 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-08-15T05:15:40.035Z,1629004540.035 [profile_station:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-08-15T05:15:40.072Z,1629004540.072 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-08-15T05:15:40.107Z,1629004540.107 [profile_station:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-08-15T05:15:40.136Z,1629004540.136 [profile_station:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-08-15T05:15:40.162Z,1629004540.162 [MissionManager](INFO): RedefineArg profile_station:Science.PeakDetectChlActive = value:1 bool 2021-08-15T05:15:40.163Z,1629004540.163 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-08-15T05:15:40.282Z,1629004540.282 [MissionManager](INFO): DefineArg profile_station:NeedComms.DiveInterval = 3.000000 h 2021-08-15T05:15:40.289Z,1629004540.289 [MissionManager](INFO): DefineArg profile_station:NeedComms.WaitForPitchUp = 10.000000 min 2021-08-15T05:15:40.291Z,1629004540.291 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-08-15T05:15:40.297Z,1629004540.297 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceDepthRate = nan m/s 2021-08-15T05:15:40.304Z,1629004540.304 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-08-15T05:15:40.306Z,1629004540.306 [MissionManager](INFO): DefineArg profile_station:NeedComms.GPSTimeout = 7.000000 min 2021-08-15T05:15:40.313Z,1629004540.313 [MissionManager](INFO): DefineArg profile_station:NeedComms.CommsTimeout = 30.000000 min 2021-08-15T05:15:40.323Z,1629004540.323 [profile_station:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-08-15T05:15:40.358Z,1629004540.358 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-08-15T05:15:40.397Z,1629004540.397 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinAltitude = 5.000000 m 2021-08-15T05:15:40.400Z,1629004540.400 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MaxDepth = 200.000000 m 2021-08-15T05:15:40.402Z,1629004540.402 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-08-15T05:15:40.403Z,1629004540.403 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-08-15T05:15:40.409Z,1629004540.409 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-08-15T05:15:40.417Z,1629004540.417 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-08-15T05:15:40.443Z,1629004540.443 [profile_station:I.Pitch](DEBUG): Construct. 2021-08-15T05:15:40.458Z,1629004540.458 [profile_station:J.Buoyancy](DEBUG): Construct Buoyancy. 2021-08-15T05:15:40.462Z,1629004540.462 [profile_station:K.SetSpeed](DEBUG): Construct. 2021-08-15T05:15:40.465Z,1629004540.465 [profile_station:L.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-08-15T05:15:40.473Z,1629004540.473 [profile_station:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-08-15T05:15:40.489Z,1629004540.489 [profile_station:N.YoYo](DEBUG): Construct YoYo. 2021-08-15T05:15:40.497Z,1629004540.497 [profile_station:CircleWrapper:B.Circle](DEBUG): Construct. 2021-08-15T05:15:40.537Z,1629004540.537 [MissionManager](DEBUG): This mission yoyos in a circle around a specified location. Maximum duration of mission 4 Elapsed time after previous surface communications when vehicle will begin to ascend for additional surface communications 60 The latitude of the center of the circle. 36.806966 The longitude of the center of the circle. -121.824326 Radius to circle at 300 Minimum depth while performing the YoYo behavior. 2 Maximum depth while performing the YoYo behavior. 200 Minimum altitude while performing the YoYo behavior (for bottom-terminated YoYos). 7 Pitch (plus and minus) for yo-yo behavior. 20 Vehicle speed. 1 If this distance away from the circle, drive straight towards (or away from the center). Otherwise, try to reduce distance from the ideal circle. 100 If true, vehicle turns to the left around the center point. If false, vehicle turns to the right. Used to relax waypoint cross-track error constant that is adjusted for docking. (You can override this setting by passing an argument.) 0.010 Minimum height above the sea floor for the entire mission. 5 Maximum depth for the entire mission. 205 Minimum offshore distance for the entire mission. 2 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. 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. 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. 2021-08-15T05:15:40.538Z,1629004540.538 [CommandLine](IMPORTANT): Loaded ./Missions/Science/profile_station.xml 2021-08-15T05:15:43.836Z,1629004543.836 [Micromodem](INFO): Nmea in: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error 2021-08-15T05:15:43.836Z,1629004543.836 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error expected 41 2021-08-15T05:15:43.838Z,1629004543.838 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T05:15:44.242Z,1629004544.242 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815051544.128241,06,716,22,0121,0150,208,02,02,01,02,-1,-01,-01,1,3,8,0,150,76.3,2.41,-100,0.59,-01,-0.34,-12,14500,4000*4D 2021-08-15T05:15:52.112Z,1629004552.112 [CommandLine](IMPORTANT): got command set profile_station.MissionTimeout 480.000000 minute 2021-08-15T05:15:52.113Z,1629004552.113 [CommandLine](IMPORTANT): got command set profile_station.NeedCommsTime 180.000000 minute 2021-08-15T05:15:52.113Z,1629004552.113 [CommandLine](IMPORTANT): got command set profile_station.Lat 41.553108 degree 2021-08-15T05:15:52.114Z,1629004552.114 [CommandLine](IMPORTANT): got command set profile_station.Lon -70.707161 degree 2021-08-15T05:16:10.873Z,1629004570.873 [CommandLine](IMPORTANT): got command set profile_station.YoYoMinDepth 3.000000 meter 2021-08-15T05:16:10.873Z,1629004570.873 [CommandLine](IMPORTANT): got command set profile_station.YoYoMaxDepth 7.000000 meter 2021-08-15T05:16:10.874Z,1629004570.874 [CommandLine](IMPORTANT): got command set profile_station.YoYoMinAltitude 3.000000 meter 2021-08-15T05:16:10.875Z,1629004570.875 [CommandLine](IMPORTANT): got command set profile_station.YoYoPitch 15.000000 degree 2021-08-15T05:16:10.876Z,1629004570.876 [CommandLine](IMPORTANT): got command set profile_station.MinAltitude 3.000000 meter 2021-08-15T05:16:10.877Z,1629004570.877 [CommandLine](IMPORTANT): got command set profile_station.MaxDepth 9.000000 meter 2021-08-15T05:16:14.213Z,1629004574.213 [CommandLine](IMPORTANT): got command set profile_station.MinOffshore 500.000000 meter 2021-08-15T05:16:14.214Z,1629004574.214 [CommandLine](IMPORTANT): got command run 2021-08-15T05:16:14.215Z,1629004574.215 [CommandLine](IMPORTANT): Running 2021-08-15T05:16:14.551Z,1629004574.551 [DefaultWithUndock] Stopped 2021-08-15T05:16:14.552Z,1629004574.552 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2021-08-15T05:16:14.552Z,1629004574.552 [DefaultWithUndock:SurfaceDefault] Stopped 2021-08-15T05:16:14.552Z,1629004574.552 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault 2021-08-15T05:16:14.552Z,1629004574.552 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped 2021-08-15T05:16:14.552Z,1629004574.552 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-08-15T05:16:14.552Z,1629004574.552 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-08-15T05:16:14.552Z,1629004574.552 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T05:16:14.553Z,1629004574.553 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-08-15T05:16:14.553Z,1629004574.553 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-15T05:16:14.553Z,1629004574.553 [MissionManager](IMPORTANT): Started mission profile_station 2021-08-15T05:16:14.553Z,1629004574.553 [profile_station] Running Loop=1 2021-08-15T05:16:14.553Z,1629004574.553 [profile_station](DEBUG): Aggregate::initialize profile_station 2021-08-15T05:16:14.553Z,1629004574.553 [profile_station:Science] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science](DEBUG): Aggregate::initialize profile_station:Science 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:A] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:B] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:C] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:D] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:E] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:F] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:Read_Oil] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:PeakDetectChl] Running Loop=1 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectChl 2021-08-15T05:16:14.554Z,1629004574.554 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2021-08-15T05:16:14.555Z,1629004574.555 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-08-15T05:16:14.556Z,1629004574.556 [profile_station:Science:HighestChlPeakReport] Running Loop=1 2021-08-15T05:16:14.556Z,1629004574.556 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize profile_station:Science:HighestChlPeakReport 2021-08-15T05:16:14.556Z,1629004574.556 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-08-15T05:16:14.557Z,1629004574.557 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-08-15T05:16:14.557Z,1629004574.557 [profile_station:Science:PeakDetectNO3] Running Loop=1 2021-08-15T05:16:14.557Z,1629004574.557 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectNO3 2021-08-15T05:16:14.557Z,1629004574.557 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2021-08-15T05:16:14.557Z,1629004574.557 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-08-15T05:16:14.559Z,1629004574.559 [profile_station:Science:PeakDetectOil] Running Loop=1 2021-08-15T05:16:14.559Z,1629004574.559 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectOil 2021-08-15T05:16:14.559Z,1629004574.559 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2021-08-15T05:16:14.559Z,1629004574.559 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-08-15T05:16:14.576Z,1629004574.576 [profile_station:Science:HighestOilPeakReport] Running Loop=1 2021-08-15T05:16:14.577Z,1629004574.577 [profile_station:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize profile_station:Science:HighestOilPeakReport 2021-08-15T05:16:14.577Z,1629004574.577 [profile_station:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-08-15T05:16:14.577Z,1629004574.577 [profile_station:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-08-15T05:16:14.577Z,1629004574.577 [profile_station:Science:PeakDetectFDOM] Running Loop=1 2021-08-15T05:16:14.577Z,1629004574.577 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectFDOM 2021-08-15T05:16:14.578Z,1629004574.578 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2021-08-15T05:16:14.578Z,1629004574.578 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-08-15T05:16:14.579Z,1629004574.579 [profile_station:Science:PeakDetectSalinity] Running Loop=1 2021-08-15T05:16:14.579Z,1629004574.579 [profile_station:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectSalinity 2021-08-15T05:16:14.579Z,1629004574.579 [profile_station:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2021-08-15T05:16:14.579Z,1629004574.579 [profile_station:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-08-15T05:16:14.581Z,1629004574.581 [profile_station:Science:HighestSaltPeakReport] Running Loop=1 2021-08-15T05:16:14.581Z,1629004574.581 [profile_station:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize profile_station:Science:HighestSaltPeakReport 2021-08-15T05:16:14.581Z,1629004574.581 [profile_station:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-08-15T05:16:14.581Z,1629004574.581 [profile_station:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-08-15T05:16:14.582Z,1629004574.582 [profile_station:Science:OceanCurrent] Running Loop=1 2021-08-15T05:16:14.582Z,1629004574.582 [profile_station:Science:OceanCurrent](DEBUG): Aggregate::initialize profile_station:Science:OceanCurrent 2021-08-15T05:16:14.582Z,1629004574.582 [profile_station:Science:OceanCurrent:A.] Running Loop=1 2021-08-15T05:16:14.582Z,1629004574.582 [profile_station:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2021-08-15T05:16:14.582Z,1629004574.582 [profile_station:StandardEnvelopes] Running Loop=1 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:StandardEnvelopes](DEBUG): Aggregate::initialize profile_station:StandardEnvelopes 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:I.Pitch] Running Loop=1 2021-08-15T05:16:14.583Z,1629004574.583 [profile_station:I.Pitch](DEBUG): Initialize. 2021-08-15T05:16:14.592Z,1629004574.592 [profile_station:J.Buoyancy] Running Loop=1 2021-08-15T05:16:14.592Z,1629004574.592 [profile_station:J.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-08-15T05:16:14.592Z,1629004574.592 [profile_station:K.SetSpeed] Running Loop=1 2021-08-15T05:16:14.592Z,1629004574.592 [profile_station:K.SetSpeed](DEBUG): Initialize. 2021-08-15T05:16:14.592Z,1629004574.592 [profile_station:L.DepthEnvelope] Running Loop=1 2021-08-15T05:16:14.593Z,1629004574.593 [profile_station:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-08-15T05:16:14.593Z,1629004574.593 [profile_station:M.AltitudeEnvelope] Running Loop=1 2021-08-15T05:16:14.593Z,1629004574.593 [profile_station:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-08-15T05:16:14.593Z,1629004574.593 [profile_station:N.YoYo] Running Loop=1 2021-08-15T05:16:14.593Z,1629004574.593 [profile_station:N.YoYo](DEBUG): Initialize YoYoComponent. 2021-08-15T05:16:14.593Z,1629004574.593 [profile_station:C] Running Loop=1 2021-08-15T05:16:14.594Z,1629004574.594 [profile_station:N.YoYo] Running Loop=1 2021-08-15T05:16:14.594Z,1629004574.594 [profile_station:M.AltitudeEnvelope] Running Loop=1 2021-08-15T05:16:14.595Z,1629004574.595 [profile_station:L.DepthEnvelope] Running Loop=1 2021-08-15T05:16:14.600Z,1629004574.600 [profile_station:K.SetSpeed] Running Loop=1 2021-08-15T05:16:14.600Z,1629004574.600 [profile_station:J.Buoyancy] Running Loop=1 2021-08-15T05:16:14.600Z,1629004574.600 [profile_station:I.Pitch] Running Loop=1 2021-08-15T05:16:14.601Z,1629004574.601 [profile_station:StandardEnvelopes] Running Loop=1 2021-08-15T05:16:14.601Z,1629004574.601 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-08-15T05:16:14.601Z,1629004574.601 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-08-15T05:16:14.602Z,1629004574.602 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-08-15T05:16:14.602Z,1629004574.602 [profile_station:C] Stopped 2021-08-15T05:16:14.602Z,1629004574.602 [profile_station:E] Running Loop=1 2021-08-15T05:16:14.602Z,1629004574.602 [profile_station:Science] Running Loop=1 2021-08-15T05:16:14.608Z,1629004574.608 [profile_station:Science:HighestSaltPeakReport] Stopped 2021-08-15T05:16:14.608Z,1629004574.608 [profile_station:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize profile_station:Science:HighestSaltPeakReport 2021-08-15T05:16:14.608Z,1629004574.608 [profile_station:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2021-08-15T05:16:14.608Z,1629004574.608 [profile_station:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-08-15T05:16:14.608Z,1629004574.608 [profile_station:Science:PeakDetectSalinity] Stopped 2021-08-15T05:16:14.608Z,1629004574.608 [profile_station:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectSalinity 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:PeakDetectFDOM] Stopped 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectFDOM 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:HighestOilPeakReport] Stopped 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize profile_station:Science:HighestOilPeakReport 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-08-15T05:16:14.609Z,1629004574.609 [profile_station:Science:PeakDetectOil] Stopped 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectOil 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:PeakDetectNO3] Stopped 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectNO3 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:HighestChlPeakReport] Stopped 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize profile_station:Science:HighestChlPeakReport 2021-08-15T05:16:14.610Z,1629004574.610 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2021-08-15T05:16:14.611Z,1629004574.611 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-08-15T05:16:14.611Z,1629004574.611 [profile_station:Science:PeakDetectChl] Running Loop=1 2021-08-15T05:16:14.611Z,1629004574.611 [profile_station:Science:OceanCurrent:A.] Running Loop=1 2021-08-15T05:16:14.614Z,1629004574.614 [profile_station:Science:Read_Oil] Running Loop=1 2021-08-15T05:16:14.615Z,1629004574.615 [profile_station:Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_petroleum_hydrocarbons_in_sea_water 2021-08-15T05:16:14.615Z,1629004574.615 [profile_station:Science:F] Stopped 2021-08-15T05:16:14.615Z,1629004574.615 [profile_station:Science:E] Running Loop=1 2021-08-15T05:16:14.615Z,1629004574.615 [profile_station:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2021-08-15T05:16:14.628Z,1629004574.628 [profile_station:Science:D] Stopped 2021-08-15T05:16:14.628Z,1629004574.628 [profile_station:Science:C] Running Loop=1 2021-08-15T05:16:14.628Z,1629004574.628 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2021-08-15T05:16:14.629Z,1629004574.629 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2021-08-15T05:16:14.629Z,1629004574.629 [profile_station:Science:B] Running Loop=1 2021-08-15T05:16:14.630Z,1629004574.630 [profile_station:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2021-08-15T05:16:14.630Z,1629004574.630 [profile_station:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2021-08-15T05:16:14.630Z,1629004574.630 [profile_station:Science:A] Stopped 2021-08-15T05:16:14.677Z,1629004574.677 [WetLabsSeaOWL_UV_A](INFO): Powering up 2021-08-15T05:16:15.019Z,1629004575.019 [profile_station:E] Stopped 2021-08-15T05:16:15.019Z,1629004575.019 [profile_station:F] Running Loop=1 2021-08-15T05:16:15.363Z,1629004575.363 [profile_station:F] Stopped 2021-08-15T05:16:15.363Z,1629004575.363 [profile_station:G] Running Loop=1 2021-08-15T05:16:15.778Z,1629004575.778 [profile_station:G] Stopped 2021-08-15T05:16:15.778Z,1629004575.778 [profile_station:StartingMission] Running Loop=1 2021-08-15T05:16:15.778Z,1629004575.778 [profile_station:StartingMission](DEBUG): Aggregate::initialize profile_station:StartingMission 2021-08-15T05:16:16.171Z,1629004576.171 [profile_station:NeedComms] Running Loop=1 2021-08-15T05:16:16.171Z,1629004576.171 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms 2021-08-15T05:16:16.172Z,1629004576.172 [profile_station:NeedComms:B.GoToSurface] Running Loop=1 2021-08-15T05:16:16.172Z,1629004576.172 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-08-15T05:16:16.172Z,1629004576.172 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2021-08-15T05:16:16.173Z,1629004576.173 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2021-08-15T05:16:16.173Z,1629004576.173 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2021-08-15T05:16:16.174Z,1629004576.174 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-08-15T05:16:16.174Z,1629004576.174 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-08-15T05:16:16.174Z,1629004576.174 [profile_station:NeedComms:A] Running Loop=1 2021-08-15T05:16:16.175Z,1629004576.175 [profile_station:NeedComms:A](INFO): last time_fix was: 1629004124.000000 second since 1970/01/01T00:00:00Z 2021-08-15T05:16:16.176Z,1629004576.176 [profile_station:NeedComms:A] Stopped 2021-08-15T05:16:16.587Z,1629004576.587 [profile_station:NeedComms:C] Running Loop=1 2021-08-15T05:16:17.023Z,1629004577.023 [profile_station:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-08-15T05:16:17.857Z,1629004577.857 [CTD_Seabird](ERROR): Failed to parse device response: 2021-08-15T05:16:18.584Z,1629004578.584 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,051619.00,A,4133.22255,N,07042.27337,W,0.525,135.68,150821,,,D*73 2021-08-15T05:16:18.587Z,1629004578.587 [NAL9602](INFO): GPS fix at 20210815T051619: (41.553709, -70.704556) 2021-08-15T05:16:18.621Z,1629004578.621 [profile_station:NeedComms:C] Stopped 2021-08-15T05:16:18.621Z,1629004578.621 [profile_station:NeedComms:D] Running Loop=1 2021-08-15T05:16:19.054Z,1629004579.054 [profile_station:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-08-15T05:16:22.724Z,1629004582.724 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210815T030024/Courier0033.lzma 2021-08-15T05:16:23.726Z,1629004583.726 [DataOverHttps](INFO): Moved sent file to Logs/20210815T030024/Courier0033.lzma.bak 2021-08-15T05:16:23.726Z,1629004583.726 [DataOverHttps](INFO): SBD MOMSN=440918 2021-08-15T05:16:32.882Z,1629004592.882 [DataOverHttps](INFO): Sending 260 bytes from file Logs/20210815T051448/Courier0000.lzma 2021-08-15T05:16:33.766Z,1629004593.766 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Courier0000.lzma.bak 2021-08-15T05:16:33.766Z,1629004593.766 [DataOverHttps](INFO): SBD MOMSN=440920 2021-08-15T05:16:33.949Z,1629004593.949 [NAL9602](INFO): SBD MO Status=0, MOMSN=24024, MT Status=0, MTMSN=0 2021-08-15T05:16:33.949Z,1629004593.949 [NAL9602](INFO): No messages in MT queue 2021-08-15T05:16:42.804Z,1629004602.804 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210815T051448/Courier0003.lzma 2021-08-15T05:16:43.806Z,1629004603.806 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Courier0003.lzma.bak 2021-08-15T05:16:43.806Z,1629004603.806 [DataOverHttps](INFO): SBD MOMSN=440924 2021-08-15T05:16:52.844Z,1629004612.844 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20210815T030024/Express0034.lzma 2021-08-15T05:16:53.846Z,1629004613.846 [DataOverHttps](INFO): Moved sent file to Logs/20210815T030024/Express0034.lzma.bak 2021-08-15T05:16:53.846Z,1629004613.846 [DataOverHttps](INFO): SBD MOMSN=440926 2021-08-15T05:17:02.896Z,1629004622.896 [DataOverHttps](INFO): Sending 830 bytes from file Logs/20210815T051448/Express0001.lzma 2021-08-15T05:17:03.889Z,1629004623.889 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Express0001.lzma.bak 2021-08-15T05:17:03.890Z,1629004623.890 [DataOverHttps](INFO): SBD MOMSN=440929 2021-08-15T05:17:04.644Z,1629004624.644 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-15T05:17:12.931Z,1629004632.931 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20210815T051448/Express0004.lzma 2021-08-15T05:17:13.934Z,1629004633.934 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Express0004.lzma.bak 2021-08-15T05:17:13.934Z,1629004633.934 [DataOverHttps](INFO): SBD MOMSN=440961 2021-08-15T05:17:15.576Z,1629004635.576 [profile_station:NeedComms:D] Stopped 2021-08-15T05:17:15.577Z,1629004635.577 [profile_station:NeedComms:E] Running Loop=1 2021-08-15T05:17:16.004Z,1629004636.004 [profile_station:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-08-15T05:17:17.584Z,1629004637.584 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,051718.00,A,4133.21599,N,07042.27329,W,0.603,160.04,150821,,,D*75 2021-08-15T05:17:17.586Z,1629004637.586 [NAL9602](INFO): GPS fix at 20210815T051718: (41.553600, -70.704555) 2021-08-15T05:17:17.601Z,1629004637.601 [profile_station:NeedComms:E] Stopped 2021-08-15T05:17:17.602Z,1629004637.602 [profile_station:NeedComms](INFO): Completed profile_station:NeedComms 2021-08-15T05:17:17.602Z,1629004637.602 [profile_station:NeedComms] Stopped 2021-08-15T05:17:17.602Z,1629004637.602 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms 2021-08-15T05:17:17.602Z,1629004637.602 [profile_station:NeedComms:B.GoToSurface] Stopped 2021-08-15T05:17:17.602Z,1629004637.602 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-08-15T05:17:18.032Z,1629004638.032 [profile_station:StartingMission](INFO): Completed profile_station:StartingMission 2021-08-15T05:17:18.032Z,1629004638.032 [profile_station:StartingMission] Stopped 2021-08-15T05:17:18.033Z,1629004638.033 [profile_station:StartingMission](DEBUG): Aggregate::uninitialize profile_station:StartingMission 2021-08-15T05:17:18.033Z,1629004638.033 [profile_station:CircleWrapper] Running Loop=1 2021-08-15T05:17:18.033Z,1629004638.033 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T05:17:18.033Z,1629004638.033 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T05:17:18.033Z,1629004638.033 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T05:17:18.033Z,1629004638.033 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T05:17:18.401Z,1629004638.401 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T05:17:20.835Z,1629004640.835 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:17:37.375Z,1629004657.375 [NAL9602](INFO): SBD MO Status=0, MOMSN=24025, MT Status=0, MTMSN=0 2021-08-15T05:17:37.376Z,1629004657.376 [NAL9602](INFO): No messages in MT queue 2021-08-15T05:17:42.803Z,1629004662.803 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T05:18:08.174Z,1629004688.174 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-15T05:18:26.822Z,1629004706.822 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T05:18:26.832Z,1629004706.832 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T05:18:36.087Z,1629004716.087 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch -15.00 deg, mass-position 2.95 mm (3 active estimators). 2021-08-15T05:19:00.737Z,1629004740.737 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 15.00 deg, mass-position 2.95 mm (4 active estimators). 2021-08-15T05:19:30.493Z,1629004770.493 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.243008 2021-08-15T05:19:36.425Z,1629004776.425 [Radio_Surface](INFO): Powering down 2021-08-15T05:19:36.516Z,1629004776.516 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-08-15T05:23:31.013Z,1629005011.013 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T05:30:15.862Z,1629005415.862 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T05:30:59.037Z,1629005459.037 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T05:31:16.043Z,1629005476.043 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:31:20.854Z,1629005480.854 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:31:30.964Z,1629005490.964 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:31:40.724Z,1629005500.724 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T05:31:56.050Z,1629005516.050 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T05:32:05.756Z,1629005525.756 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T05:32:10.951Z,1629005530.951 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T05:32:48.118Z,1629005568.118 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:33:09.935Z,1629005589.935 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T05:33:35.842Z,1629005615.842 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T05:34:06.135Z,1629005646.135 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:35:36.672Z,1629005736.672 [CTD_Seabird](ERROR): Failed to parse device response: 55,4852.62 2021-08-15T05:36:42.101Z,1629005802.101 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:37:03.954Z,1629005823.954 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T05:40:50.135Z,1629006050.135 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T05:40:50.137Z,1629006050.137 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T05:43:01.862Z,1629006181.862 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T05:51:06.716Z,1629006666.716 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:51:31.721Z,1629006691.721 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:51:36.974Z,1629006696.974 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T05:51:51.935Z,1629006711.935 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T05:52:44.023Z,1629006764.023 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:52:52.124Z,1629006772.124 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T05:53:01.810Z,1629006781.810 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:53:11.901Z,1629006791.901 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T05:53:22.017Z,1629006802.017 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T05:53:32.124Z,1629006812.124 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T05:56:12.106Z,1629006972.106 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T05:56:27.032Z,1629006987.032 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T05:58:25.852Z,1629007105.852 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T05:58:25.852Z,1629007105.852 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T05:58:25.852Z,1629007105.852 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T05:58:25.961Z,1629007105.961 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T05:58:26.288Z,1629007106.288 [RDI_Pathfinder](INFO): Powering down 2021-08-15T05:58:27.224Z,1629007107.224 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T05:58:27.224Z,1629007107.224 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T05:59:11.887Z,1629007151.887 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T06:02:20.963Z,1629007340.963 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:02:36.715Z,1629007356.715 [RDI_PathfinderUp](ERROR): only read 1 of 4 data items 2021-08-15T06:05:47.838Z,1629007547.838 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T06:06:35.903Z,1629007595.903 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T06:06:35.903Z,1629007595.903 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T06:06:35.904Z,1629007595.904 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T06:06:35.904Z,1629007595.904 [profile_station:CircleWrapper] Stopped 2021-08-15T06:06:35.904Z,1629007595.904 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T06:06:35.904Z,1629007595.904 [profile_station:CircleWrapper:A] Stopped 2021-08-15T06:06:35.904Z,1629007595.904 [profile_station:CircleWrapper](INFO): Running loop #2 2021-08-15T06:06:35.905Z,1629007595.905 [profile_station:CircleWrapper] Running Loop=2 2021-08-15T06:06:35.905Z,1629007595.905 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T06:06:35.905Z,1629007595.905 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T06:06:35.905Z,1629007595.905 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T06:06:35.905Z,1629007595.905 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T06:07:17.548Z,1629007637.548 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T06:07:23.971Z,1629007643.971 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T06:07:45.790Z,1629007665.790 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T06:07:47.815Z,1629007667.815 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:07:57.558Z,1629007677.558 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T06:08:07.605Z,1629007687.605 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T06:08:57.722Z,1629007737.722 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:11:17.905Z,1629007877.905 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T06:11:27.688Z,1629007887.688 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:11:32.852Z,1629007892.852 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T06:11:42.955Z,1629007902.955 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:11:57.892Z,1629007917.892 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:12:12.838Z,1629007932.838 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T06:12:22.951Z,1629007942.951 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:12:27.838Z,1629007947.838 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:12:33.044Z,1629007953.044 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:14:22.925Z,1629008062.925 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T06:16:47.979Z,1629008207.979 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:24:37.845Z,1629008677.845 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T06:27:13.766Z,1629008833.766 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T06:27:21.514Z,1629008841.514 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2021-08-15T06:27:23.522Z,1629008843.522 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T06:27:33.559Z,1629008853.559 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:28:33.791Z,1629008913.791 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:30:15.596Z,1629009015.596 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T06:30:15.596Z,1629009015.596 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T06:30:15.596Z,1629009015.596 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T06:30:15.716Z,1629009015.716 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T06:30:16.033Z,1629009016.033 [RDI_Pathfinder](INFO): Powering down 2021-08-15T06:30:16.912Z,1629009016.912 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T06:30:16.912Z,1629009016.912 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T06:31:33.967Z,1629009093.967 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:31:43.690Z,1629009103.690 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T06:31:48.894Z,1629009108.894 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T06:32:13.961Z,1629009133.961 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:35:52.502Z,1629009352.502 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:40:52.366Z,1629009652.366 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T06:43:11.320Z,1629009791.320 [CBIT](IMPORTANT): Beginning ground fault scan 2021-08-15T06:43:11.358Z,1629009791.358 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:12.362Z,1629009792.362 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:13.366Z,1629009793.366 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:14.370Z,1629009794.370 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:15.374Z,1629009795.374 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:16.378Z,1629009796.378 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:17.382Z,1629009797.382 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:18.386Z,1629009798.386 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:19.390Z,1629009799.390 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:20.394Z,1629009800.394 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:21.398Z,1629009801.398 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T06:43:22.317Z,1629009802.317 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.095836 CHAN A1 (24V): 0.089804 CHAN A2 (12V): 0.034779 CHAN A3 (5V): 0.010876 CHAN B0 (3.3V): 0.013457 CHAN B1 (3.15aV): 0.014676 CHAN B2 (3.15bV): 0.017366 CHAN B3 (GND): 0.004985 OPEN: 0.014511 Full Scale Calc: 4.765 mA, -1.589 mA 2021-08-15T06:43:29.473Z,1629009809.473 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:43:54.523Z,1629009834.523 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:44:04.614Z,1629009844.614 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T06:44:14.359Z,1629009854.359 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:44:24.405Z,1629009864.405 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2021-08-15T06:44:44.624Z,1629009884.624 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:44:54.374Z,1629009894.374 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T06:45:24.659Z,1629009924.659 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:46:01.382Z,1629009961.382 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2021-08-15T06:48:14.708Z,1629010094.708 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T06:48:14.711Z,1629010094.711 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T06:50:19.949Z,1629010219.949 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:50:43.772Z,1629010243.772 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:51:19.734Z,1629010279.734 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T06:51:29.830Z,1629010289.830 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T06:51:34.690Z,1629010294.690 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:51:44.782Z,1629010304.782 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T06:51:54.890Z,1629010314.890 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:51:59.728Z,1629010319.728 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T06:53:13.258Z,1629010393.258 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T06:53:13.258Z,1629010393.258 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T06:53:13.272Z,1629010393.272 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T06:53:13.272Z,1629010393.272 [profile_station:CircleWrapper] Stopped 2021-08-15T06:53:13.272Z,1629010393.272 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T06:53:13.272Z,1629010393.272 [profile_station:CircleWrapper:A] Stopped 2021-08-15T06:53:13.272Z,1629010393.272 [profile_station:CircleWrapper](INFO): Running loop #3 2021-08-15T06:53:13.272Z,1629010393.272 [profile_station:CircleWrapper] Running Loop=3 2021-08-15T06:53:13.272Z,1629010393.272 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T06:53:13.273Z,1629010393.273 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T06:53:13.273Z,1629010393.273 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T06:53:13.273Z,1629010393.273 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T06:53:29.836Z,1629010409.836 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:53:37.989Z,1629010417.989 [CTD_Seabird](ERROR): Failed to parse device response: .93 2021-08-15T06:55:26.985Z,1629010526.985 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T06:57:54.461Z,1629010674.461 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T06:58:16.315Z,1629010696.315 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T06:58:54.648Z,1629010734.648 [ElevatorServo](ERROR): getPosition uart error serial timeout 2021-08-15T06:58:54.648Z,1629010734.648 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout 2021-08-15T06:58:54.648Z,1629010734.648 [ElevatorServo] Communications Fault, FailCount= 1 2021-08-15T06:58:54.648Z,1629010734.648 [ElevatorServo](ERROR): Communications Fault 2021-08-15T06:58:54.696Z,1629010734.696 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2021-08-15T06:58:54.837Z,1629010734.837 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-08-15T06:58:54.837Z,1629010734.837 [ElevatorServo](INFO): Powering down 2021-08-15T06:58:55.549Z,1629010735.549 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-08-15T06:58:55.669Z,1629010735.669 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-08-15T06:58:55.680Z,1629010735.680 [CBIT](INFO): Clearing failed state for component ElevatorServo 2021-08-15T06:58:55.680Z,1629010735.680 [ElevatorServo] No Fault, FailCount= 1 2021-08-15T07:03:50.475Z,1629011030.475 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:03:52.493Z,1629011032.493 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:03:56.546Z,1629011036.546 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:04:00.575Z,1629011040.575 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:04:05.419Z,1629011045.419 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:04:10.321Z,1629011050.321 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:04:15.118Z,1629011055.118 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,070416,AUV,239330*7F expected 21 2021-08-15T07:04:30.467Z,1629011070.467 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T07:04:46.658Z,1629011086.658 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:05:10.467Z,1629011110.467 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T07:05:20.578Z,1629011120.578 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:08:50.699Z,1629011330.699 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:11:15.700Z,1629011475.700 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:11:20.966Z,1629011480.966 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:11:45.996Z,1629011505.996 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:12:05.795Z,1629011525.795 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:12:15.915Z,1629011535.915 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:12:20.749Z,1629011540.749 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:12:26.011Z,1629011546.011 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:14:08.679Z,1629011648.679 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:17:18.494Z,1629011838.494 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:20:02.934Z,1629012002.934 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T07:20:04.560Z,1629012004.560 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:20:46.556Z,1629012046.556 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:22:45.730Z,1629012165.730 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:23:26.549Z,1629012206.549 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:23:36.294Z,1629012216.294 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:23:46.331Z,1629012226.331 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:24:06.541Z,1629012246.541 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:24:16.302Z,1629012256.302 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T07:24:26.344Z,1629012266.344 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T07:24:36.464Z,1629012276.464 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T07:24:36.464Z,1629012276.464 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T07:24:36.464Z,1629012276.464 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T07:24:36.624Z,1629012276.624 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T07:24:36.908Z,1629012276.908 [RDI_Pathfinder](INFO): Powering down 2021-08-15T07:24:37.951Z,1629012277.951 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T07:24:37.951Z,1629012277.951 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T07:27:38.264Z,1629012458.264 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T07:27:38.264Z,1629012458.264 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T07:27:38.264Z,1629012458.264 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T07:27:38.352Z,1629012458.352 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T07:27:38.708Z,1629012458.708 [RDI_Pathfinder](INFO): Powering down 2021-08-15T07:27:39.505Z,1629012459.505 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T07:27:39.505Z,1629012459.505 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T07:30:16.224Z,1629012616.224 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:31:01.864Z,1629012661.864 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:31:11.994Z,1629012671.994 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:31:27.724Z,1629012687.724 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:31:36.660Z,1629012696.660 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T07:31:41.881Z,1629012701.881 [RDI_PathfinderUp](ERROR): DVL uart error: serial timeout 2021-08-15T07:31:41.881Z,1629012701.881 [RDI_PathfinderUp] Communications Fault, FailCount= 1 2021-08-15T07:31:41.882Z,1629012701.882 [RDI_PathfinderUp](ERROR): Communications Fault 2021-08-15T07:31:42.120Z,1629012702.120 [CBIT](ERROR): Communications Fault in component: RDI_PathfinderUp 2021-08-15T07:31:42.372Z,1629012702.372 [RDI_PathfinderUp](INFO): Powering down 2021-08-15T07:31:43.129Z,1629012703.129 [CBIT](INFO): Clearing failed state for component RDI_PathfinderUp 2021-08-15T07:31:43.129Z,1629012703.129 [RDI_PathfinderUp] No Fault, FailCount= 1 2021-08-15T07:32:26.709Z,1629012746.709 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:36:52.146Z,1629013012.146 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:37:11.960Z,1629013031.960 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:37:22.031Z,1629013042.031 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:37:51.988Z,1629013071.988 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T07:38:12.130Z,1629013092.130 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2021-08-15T07:38:22.237Z,1629013102.237 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2021-08-15T07:38:31.989Z,1629013111.989 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:39:59.612Z,1629013199.612 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T07:39:59.613Z,1629013199.613 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T07:39:59.613Z,1629013199.613 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T07:39:59.613Z,1629013199.613 [profile_station:CircleWrapper] Stopped 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper:A] Stopped 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper](INFO): Running loop #4 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper] Running Loop=4 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T07:39:59.614Z,1629013199.614 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T07:41:49.982Z,1629013309.982 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:42:52.501Z,1629013372.501 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T07:46:52.083Z,1629013612.083 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T07:49:39.008Z,1629013779.008 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:49:52.695Z,1629013792.695 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:50:02.575Z,1629013802.575 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:50:07.635Z,1629013807.635 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:50:12.893Z,1629013812.893 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:50:22.619Z,1629013822.619 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:50:27.833Z,1629013827.833 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T07:50:37.920Z,1629013837.920 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:50:42.833Z,1629013842.833 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:51:02.615Z,1629013862.615 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:51:07.828Z,1629013867.828 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T07:51:23.242Z,1629013883.242 [CTD_Seabird](ERROR): Failed to parse device response: 9,4.79685,4809.22 2021-08-15T07:55:38.956Z,1629014138.956 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T07:55:38.959Z,1629014138.959 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T07:57:02.981Z,1629014222.981 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:57:13.089Z,1629014233.089 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T07:57:23.167Z,1629014243.167 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:57:33.264Z,1629014253.264 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T07:58:23.023Z,1629014303.023 [RDI_Pathfinder](ERROR): only read 1 of 4 data items 2021-08-15T07:58:33.111Z,1629014313.111 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:03:43.759Z,1629014623.759 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:04:20.584Z,1629014660.584 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:04:36.283Z,1629014676.283 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:05:32.855Z,1629014732.855 [RDI_PathfinderUp](ERROR): only read 1 of 4 data items 2021-08-15T08:06:22.568Z,1629014782.568 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:09:43.749Z,1629014983.749 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:10:03.567Z,1629015003.567 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:10:28.582Z,1629015028.582 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:10:33.836Z,1629015033.836 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:10:43.577Z,1629015043.577 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:10:48.788Z,1629015048.788 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:10:53.631Z,1629015053.631 [RDI_PathfinderUp](ERROR): only read 1 of 4 data items 2021-08-15T08:10:58.891Z,1629015058.891 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:11:18.699Z,1629015078.699 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:14:35.063Z,1629015275.063 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:17:23.985Z,1629015443.985 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T08:17:34.013Z,1629015454.013 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T08:17:44.103Z,1629015464.103 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:17:54.205Z,1629015474.205 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:17:58.291Z,1629015478.291 [profile_station:NeedComms] Running Loop=1 2021-08-15T08:17:58.291Z,1629015478.291 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms 2021-08-15T08:17:58.291Z,1629015478.291 [profile_station:NeedComms:B.GoToSurface] Running Loop=1 2021-08-15T08:17:58.291Z,1629015478.291 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-08-15T08:17:58.291Z,1629015478.291 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2021-08-15T08:17:58.296Z,1629015478.296 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2021-08-15T08:17:58.297Z,1629015478.297 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2021-08-15T08:17:58.297Z,1629015478.297 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-08-15T08:17:58.298Z,1629015478.298 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-08-15T08:17:58.298Z,1629015478.298 [profile_station:NeedComms:A] Running Loop=1 2021-08-15T08:17:58.304Z,1629015478.304 [profile_station:NeedComms:A](INFO): last time_fix was: 1629004638.000000 second since 1970/01/01T00:00:00Z 2021-08-15T08:17:58.304Z,1629015478.304 [profile_station:NeedComms:A] Stopped 2021-08-15T08:18:14.018Z,1629015494.018 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T08:18:36.291Z,1629015516.291 [profile_station:NeedComms:C] Running Loop=1 2021-08-15T08:18:36.868Z,1629015516.868 [Radio_Surface](INFO): Powering up 2021-08-15T08:18:42.888Z,1629015522.888 [DataOverHttps](INFO): Radio surface powered ON. 2021-08-15T08:18:43.986Z,1629015523.986 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T08:19:04.108Z,1629015544.108 [NAL9602](INFO): SBD MO Status=0, MOMSN=24026, MT Status=0, MTMSN=0 2021-08-15T08:19:04.108Z,1629015544.108 [NAL9602](INFO): No messages in MT queue 2021-08-15T08:19:04.153Z,1629015544.153 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:19:13.012Z,1629015553.012 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T08:19:14.235Z,1629015554.235 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:19:48.160Z,1629015588.160 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T08:20:23.300Z,1629015623.300 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T08:20:34.229Z,1629015634.229 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:20:58.440Z,1629015658.440 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T08:21:33.596Z,1629015693.596 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T08:22:02.729Z,1629015722.729 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.012994 2021-08-15T08:22:53.994Z,1629015773.994 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,082255.00,A,4133.28930,N,07042.40373,W,1.516,0.00,150821,,,A*7F 2021-08-15T08:22:53.997Z,1629015773.997 [NAL9602](INFO): GPS fix at 20210815T082255: (41.554822, -70.706729) 2021-08-15T08:22:54.029Z,1629015774.029 [UniversalFixResidualReporter](INFO): Fix residual: 0.8 %DT, over the last 7347.3 m. Residual distance 61.3 m at bearing -5.2 degrees. Fix at (41.5548, -70.7067) with 226.2 m made good. 2021-08-15T08:22:54.034Z,1629015774.034 [profile_station:NeedComms:C] Stopped 2021-08-15T08:22:54.035Z,1629015774.035 [profile_station:NeedComms:D] Running Loop=1 2021-08-15T08:22:57.960Z,1629015777.960 [DataOverHttps](INFO): Sending 270 bytes from file Logs/20210815T051448/Courier0006.lzma 2021-08-15T08:22:58.962Z,1629015778.962 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Courier0006.lzma.bak 2021-08-15T08:22:58.962Z,1629015778.962 [DataOverHttps](INFO): SBD MOMSN=441484 2021-08-15T08:22:59.283Z,1629015779.283 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:23:08.011Z,1629015788.011 [DataOverHttps](INFO): Sending 2036 bytes from file Logs/20210815T051448/Express0007.lzma 2021-08-15T08:23:09.006Z,1629015789.006 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Express0007.lzma.bak 2021-08-15T08:23:09.006Z,1629015789.006 [DataOverHttps](INFO): SBD MOMSN=441487 2021-08-15T08:23:10.603Z,1629015790.603 [profile_station:NeedComms:D] Stopped 2021-08-15T08:23:10.603Z,1629015790.603 [profile_station:NeedComms:E] Running Loop=1 2021-08-15T08:23:12.596Z,1629015792.596 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,082314.00,A,4133.29051,N,07042.40483,W,0.369,0.00,150821,,,A*73 2021-08-15T08:23:12.598Z,1629015792.598 [NAL9602](INFO): GPS fix at 20210815T082314: (41.554842, -70.706747) 2021-08-15T08:23:12.652Z,1629015792.652 [profile_station:NeedComms:E] Stopped 2021-08-15T08:23:12.653Z,1629015792.653 [profile_station:NeedComms](INFO): Completed profile_station:NeedComms 2021-08-15T08:23:12.653Z,1629015792.653 [profile_station:NeedComms] Stopped 2021-08-15T08:23:12.653Z,1629015792.653 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms 2021-08-15T08:23:12.654Z,1629015792.654 [profile_station:NeedComms:B.GoToSurface] Stopped 2021-08-15T08:23:12.654Z,1629015792.654 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-08-15T08:23:13.411Z,1629015793.411 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -26.00 mm. 2021-08-15T08:23:13.412Z,1629015793.412 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position 2.95 mm. 2021-08-15T08:23:18.682Z,1629015798.682 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:23:31.868Z,1629015811.868 [BuoyancyServo](FAULT): Invalid EZ Servo response:"" 2021-08-15T08:23:31.868Z,1629015811.868 [BuoyancyServo] Communications Fault, FailCount= 1 2021-08-15T08:23:31.868Z,1629015811.868 [BuoyancyServo](ERROR): Communications Fault 2021-08-15T08:23:31.869Z,1629015811.869 [BuoyancyServo](FAULT): Buoyancy engine reporting null position 2021-08-15T08:23:31.869Z,1629015811.869 [BuoyancyServo] Hardware Fault, FailCount= 1 2021-08-15T08:23:31.869Z,1629015811.869 [BuoyancyServo](ERROR): Hardware Fault 2021-08-15T08:23:32.097Z,1629015812.097 [CBIT](ERROR): Hardware Fault in component: BuoyancyServo 2021-08-15T08:23:32.285Z,1629015812.285 [CTD_Seabird](ERROR): Failed to parse device response: 0.14,24.239.37 2021-08-15T08:23:33.825Z,1629015813.825 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-08-15T08:23:33.825Z,1629015813.825 [BuoyancyServo](INFO): Powering down 2021-08-15T08:23:34.776Z,1629015814.776 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2021-08-15T08:23:34.776Z,1629015814.776 [BuoyancyServo] No Fault, FailCount= 1 2021-08-15T08:23:35.151Z,1629015815.151 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-08-15T08:23:35.156Z,1629015815.156 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-08-15T08:23:45.078Z,1629015825.078 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-15T08:26:32.067Z,1629015992.067 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:29:39.789Z,1629016179.789 [CTD_Seabird](ERROR): Failed to parse device response: 8.42,24.2695,4.794.19 2021-08-15T08:30:06.725Z,1629016206.725 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.244087 2021-08-15T08:30:08.340Z,1629016208.340 [Radio_Surface](INFO): Powering down 2021-08-15T08:30:08.732Z,1629016208.732 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-08-15T08:30:14.648Z,1629016214.648 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:30:28.985Z,1629016228.985 [CTD_Seabird](ERROR): Failed to parse device response: 62,4781.67 2021-08-15T08:30:39.702Z,1629016239.702 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:30:44.579Z,1629016244.579 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:30:59.979Z,1629016259.979 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T08:31:10.808Z,1629016270.808 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:31:39.956Z,1629016299.956 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T08:33:39.951Z,1629016419.951 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T08:34:04.565Z,1629016444.565 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:34:24.774Z,1629016464.774 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T08:34:24.774Z,1629016464.774 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T08:34:24.775Z,1629016464.775 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T08:34:24.775Z,1629016464.775 [profile_station:CircleWrapper] Stopped 2021-08-15T08:34:24.775Z,1629016464.775 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T08:34:24.775Z,1629016464.775 [profile_station:CircleWrapper:A] Stopped 2021-08-15T08:34:24.775Z,1629016464.775 [profile_station:CircleWrapper](INFO): Running loop #5 2021-08-15T08:34:24.775Z,1629016464.775 [profile_station:CircleWrapper] Running Loop=5 2021-08-15T08:34:24.775Z,1629016464.775 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T08:34:24.776Z,1629016464.776 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T08:34:24.776Z,1629016464.776 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T08:34:24.776Z,1629016464.776 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T08:37:39.959Z,1629016659.959 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:37:49.994Z,1629016669.994 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T08:38:10.171Z,1629016690.171 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T08:38:19.954Z,1629016699.954 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T08:38:29.973Z,1629016709.973 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T08:38:50.195Z,1629016730.195 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T08:38:50.195Z,1629016730.195 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T08:38:50.195Z,1629016730.195 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T08:38:50.256Z,1629016730.256 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T08:38:50.636Z,1629016730.636 [RDI_Pathfinder](INFO): Powering down 2021-08-15T08:38:51.456Z,1629016731.456 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T08:38:51.456Z,1629016731.456 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T08:40:40.091Z,1629016840.091 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:43:22.561Z,1629017002.561 [CBIT](IMPORTANT): Beginning ground fault scan 2021-08-15T08:43:23.178Z,1629017003.178 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:24.182Z,1629017004.182 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:25.186Z,1629017005.186 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:26.120Z,1629017006.120 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T08:43:26.190Z,1629017006.190 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:27.194Z,1629017007.194 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:28.198Z,1629017008.198 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:29.202Z,1629017009.202 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:30.206Z,1629017010.206 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:31.210Z,1629017011.210 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:32.214Z,1629017012.214 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:33.218Z,1629017013.218 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T08:43:33.927Z,1629017013.927 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.033601 CHAN A1 (24V): 0.010002 CHAN A2 (12V): 0.013906 CHAN A3 (5V): 0.009094 CHAN B0 (3.3V): 0.010422 CHAN B1 (3.15aV): 0.011302 CHAN B2 (3.15bV): 0.011258 CHAN B3 (GND): 0.005085 OPEN: 0.008410 Full Scale Calc: 4.765 mA, -1.589 mA 2021-08-15T08:48:19.891Z,1629017299.891 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:49:24.074Z,1629017364.074 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T08:50:07.685Z,1629017407.685 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:50:35.563Z,1629017435.563 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:50:40.818Z,1629017440.818 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T08:50:50.562Z,1629017450.562 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:51:00.625Z,1629017460.625 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:51:04.660Z,1629017464.660 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:51:06.668Z,1629017466.668 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:51:10.719Z,1629017470.719 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:51:15.577Z,1629017475.577 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:51:30.564Z,1629017490.564 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T08:53:00.654Z,1629017580.654 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:53:05.899Z,1629017585.899 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T08:54:40.795Z,1629017680.795 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:56:25.868Z,1629017785.868 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:56:48.875Z,1629017808.875 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T08:56:56.141Z,1629017816.141 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T08:57:17.969Z,1629017837.969 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T08:57:26.049Z,1629017846.049 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T08:57:38.182Z,1629017858.182 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T08:57:45.916Z,1629017865.916 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T08:57:45.916Z,1629017865.916 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T08:57:45.916Z,1629017865.916 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T08:57:46.018Z,1629017866.018 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T08:57:46.300Z,1629017866.300 [RDI_Pathfinder](INFO): Powering down 2021-08-15T08:57:47.116Z,1629017867.116 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T08:57:47.116Z,1629017867.116 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T08:59:39.766Z,1629017979.766 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:02:34.695Z,1629018154.695 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:03:02.982Z,1629018182.982 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T09:03:02.985Z,1629018182.985 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T09:05:07.855Z,1629018307.855 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T09:08:13.756Z,1629018493.756 [RDI_Pathfinder](ERROR): only read -1 of 1 data item for altitude 2021-08-15T09:08:14.878Z,1629018494.878 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:08:18.354Z,1629018498.354 [CTD_Seabird](ERROR): Failed to parse device response: 3.26,24.250.98 2021-08-15T09:10:10.027Z,1629018610.027 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:12:26.635Z,1629018746.635 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T09:12:32.641Z,1629018752.641 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T09:13:26.781Z,1629018806.781 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:13:31.738Z,1629018811.738 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T09:13:51.821Z,1629018831.821 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:14:01.919Z,1629018841.919 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:14:31.852Z,1629018871.852 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T09:14:31.852Z,1629018871.852 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T09:14:31.852Z,1629018871.852 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T09:14:32.120Z,1629018872.120 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T09:14:32.280Z,1629018872.280 [RDI_Pathfinder](INFO): Powering down 2021-08-15T09:14:33.096Z,1629018873.096 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T09:14:33.096Z,1629018873.096 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T09:18:03.924Z,1629019083.924 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T09:21:38.850Z,1629019298.850 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:21:58.672Z,1629019318.672 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T09:21:58.672Z,1629019318.672 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T09:21:58.673Z,1629019318.673 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T09:21:58.673Z,1629019318.673 [profile_station:CircleWrapper] Stopped 2021-08-15T09:21:58.673Z,1629019318.673 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T09:21:58.673Z,1629019318.673 [profile_station:CircleWrapper:A] Stopped 2021-08-15T09:21:58.673Z,1629019318.673 [profile_station:CircleWrapper](INFO): Running loop #6 2021-08-15T09:21:58.674Z,1629019318.674 [profile_station:CircleWrapper] Running Loop=6 2021-08-15T09:21:58.674Z,1629019318.674 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T09:21:58.674Z,1629019318.674 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T09:21:58.674Z,1629019318.674 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T09:21:58.674Z,1629019318.674 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T09:22:48.748Z,1629019368.748 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:29:57.835Z,1629019797.835 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:30:07.525Z,1629019807.525 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:30:17.639Z,1629019817.639 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T09:30:57.660Z,1629019857.660 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T09:30:57.660Z,1629019857.660 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T09:30:57.660Z,1629019857.660 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T09:30:57.756Z,1629019857.756 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T09:30:58.100Z,1629019858.100 [RDI_Pathfinder](INFO): Powering down 2021-08-15T09:30:58.904Z,1629019858.904 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T09:30:58.904Z,1629019858.904 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T09:31:15.809Z,1629019875.809 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T09:31:35.639Z,1629019895.639 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:32:37.821Z,1629019957.821 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:32:42.660Z,1629019962.660 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T09:32:47.909Z,1629019967.909 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T09:32:57.656Z,1629019977.656 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:33:02.864Z,1629019982.864 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:33:17.824Z,1629019997.824 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:33:32.758Z,1629020012.758 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:33:42.854Z,1629020022.854 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:36:13.586Z,1629020173.586 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T09:39:35.616Z,1629020375.616 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:40:23.664Z,1629020423.664 [RDI_Pathfinder](ERROR): only read -1 of 4 data items 2021-08-15T09:43:06.005Z,1629020586.005 [CTD_Seabird](ERROR): Failed to parse device response: 4.232,4.79213,4789.44 2021-08-15T09:45:06.870Z,1629020706.870 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:45:45.642Z,1629020745.642 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:46:13.538Z,1629020773.538 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:46:53.515Z,1629020813.515 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:47:03.639Z,1629020823.639 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T09:47:13.345Z,1629020833.345 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T09:47:23.423Z,1629020843.423 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T09:47:35.604Z,1629020855.604 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T09:48:03.430Z,1629020883.430 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:51:14.919Z,1629021074.919 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:51:58.600Z,1629021118.600 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:52:28.852Z,1629021148.852 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:52:38.944Z,1629021158.944 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:52:43.803Z,1629021163.803 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:52:53.896Z,1629021173.896 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T09:52:59.632Z,1629021179.632 [RDI_PathfinderUp](ERROR): only read 1 of 4 data items 2021-08-15T09:53:08.842Z,1629021188.842 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T09:53:13.691Z,1629021193.691 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T09:53:23.819Z,1629021203.819 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:57:41.606Z,1629021461.606 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:57:43.618Z,1629021463.618 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T09:58:21.590Z,1629021501.590 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T10:00:10.333Z,1629021610.333 [ThrusterServo](FAULT): Invalid EZ Servo response:"\377\377\325242" 2021-08-15T10:00:10.333Z,1629021610.333 [ThrusterServo] Communications Fault, FailCount= 1 2021-08-15T10:00:10.333Z,1629021610.333 [ThrusterServo](ERROR): Communications Fault 2021-08-15T10:00:10.338Z,1629021610.338 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-08-15T10:00:10.701Z,1629021610.701 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-08-15T10:00:10.701Z,1629021610.701 [ThrusterServo](INFO): Powering down 2021-08-15T10:00:11.487Z,1629021611.487 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-08-15T10:00:11.601Z,1629021611.601 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-08-15T10:00:11.605Z,1629021611.605 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-08-15T10:00:11.605Z,1629021611.605 [ThrusterServo] No Fault, FailCount= 1 2021-08-15T10:02:26.797Z,1629021746.797 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:05:49.589Z,1629021949.589 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:05:59.361Z,1629021959.361 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:06:09.387Z,1629021969.387 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:06:41.325Z,1629022001.325 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T10:07:13.622Z,1629022033.622 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:07:19.406Z,1629022039.406 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:08:32.409Z,1629022112.409 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T10:08:32.409Z,1629022112.409 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T10:08:32.410Z,1629022112.410 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T10:08:32.410Z,1629022112.410 [profile_station:CircleWrapper] Stopped 2021-08-15T10:08:32.410Z,1629022112.410 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T10:08:32.410Z,1629022112.410 [profile_station:CircleWrapper:A] Stopped 2021-08-15T10:08:32.410Z,1629022112.410 [profile_station:CircleWrapper](INFO): Running loop #7 2021-08-15T10:08:32.410Z,1629022112.410 [profile_station:CircleWrapper] Running Loop=7 2021-08-15T10:08:32.411Z,1629022112.411 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T10:08:32.411Z,1629022112.411 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T10:08:32.411Z,1629022112.411 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T10:08:32.411Z,1629022112.411 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T10:10:27.194Z,1629022227.194 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T10:10:27.201Z,1629022227.201 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T10:12:10.657Z,1629022330.657 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:12:24.767Z,1629022344.767 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:12:34.865Z,1629022354.865 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:12:44.617Z,1629022364.617 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:12:54.654Z,1629022374.654 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:12:59.911Z,1629022379.911 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:13:04.772Z,1629022384.772 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T10:14:31.623Z,1629022471.623 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:14:49.810Z,1629022489.810 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:15:03.557Z,1629022503.557 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T10:16:19.889Z,1629022579.889 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:17:25.745Z,1629022645.745 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:17:35.037Z,1629022655.037 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T10:20:57.460Z,1629022857.460 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:25:45.517Z,1629023145.517 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T10:25:55.277Z,1629023155.277 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:26:05.315Z,1629023165.315 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:26:15.426Z,1629023175.426 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T10:26:25.562Z,1629023185.562 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T10:26:35.298Z,1629023195.298 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T10:27:15.629Z,1629023235.629 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:27:19.649Z,1629023239.649 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T10:32:05.710Z,1629023525.710 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:32:21.879Z,1629023541.879 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T10:32:40.965Z,1629023560.965 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:32:45.699Z,1629023565.699 [RDI_PathfinderUp](ERROR): only read 1 of 4 data items 2021-08-15T10:33:05.591Z,1629023585.591 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:33:15.657Z,1629023595.657 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:34:07.769Z,1629023647.769 [CTD_Seabird](ERROR): Failed to parse device response: 29,4779.98 2021-08-15T10:34:09.352Z,1629023649.352 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:39:51.167Z,1629023991.167 [CTD_Seabird](ERROR): Failed to parse device response: .92 2021-08-15T10:42:27.475Z,1629024147.475 [Micromodem](INFO): Nmea in: *76 2021-08-15T10:42:27.476Z,1629024147.476 [Micromodem](ERROR): Response from modem failed NMEA checksum: *76 expected 0 2021-08-15T10:43:26.086Z,1629024206.086 [CTD_Seabird](ERROR): Failed to parse device response: 6.91,,4.78645,4768.79 2021-08-15T10:43:34.300Z,1629024214.300 [CBIT](IMPORTANT): Beginning ground fault scan 2021-08-15T10:43:35.122Z,1629024215.122 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:36.126Z,1629024216.126 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:37.132Z,1629024217.132 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:38.133Z,1629024218.133 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:39.138Z,1629024219.138 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:40.142Z,1629024220.142 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:41.145Z,1629024221.145 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:42.150Z,1629024222.150 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:43.154Z,1629024223.154 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:44.158Z,1629024224.158 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:45.166Z,1629024225.166 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T10:43:45.175Z,1629024225.175 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.002843 CHAN A1 (24V): -0.003753 CHAN A2 (12V): 0.004615 CHAN A3 (5V): 0.001669 CHAN B0 (3.3V): 0.003315 CHAN B1 (3.15aV): 0.003098 CHAN B2 (3.15bV): 0.003577 CHAN B3 (GND): 0.001985 OPEN: 0.007583 Full Scale Calc: 4.765 mA, -1.589 mA 2021-08-15T10:44:21.403Z,1629024261.403 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:44:33.572Z,1629024273.572 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:44:41.261Z,1629024281.261 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T10:44:51.323Z,1629024291.323 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:45:01.402Z,1629024301.402 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T10:45:15.947Z,1629024315.947 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:45:31.317Z,1629024331.317 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T10:45:41.405Z,1629024341.405 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T10:45:51.513Z,1629024351.513 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:47:12.711Z,1629024432.711 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:51:11.548Z,1629024671.548 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:51:36.569Z,1629024696.569 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:51:41.776Z,1629024701.776 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T10:51:52.674Z,1629024712.674 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:51:56.723Z,1629024716.723 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:52:06.818Z,1629024726.818 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T10:52:16.581Z,1629024736.581 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:52:26.640Z,1629024746.640 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T10:52:31.874Z,1629024751.874 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:52:38.748Z,1629024758.748 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T10:54:14.497Z,1629024854.497 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T10:54:14.497Z,1629024854.497 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T10:54:14.497Z,1629024854.497 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper] Stopped 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper:A] Stopped 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper](INFO): Running loop #8 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper] Running Loop=8 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T10:54:14.498Z,1629024854.498 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T10:54:35.551Z,1629024875.551 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T10:55:25.274Z,1629024925.274 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T10:58:16.542Z,1629025096.542 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T11:02:34.624Z,1629025354.624 [RudderServo](ERROR): getPosition uart error serial timeout 2021-08-15T11:02:34.624Z,1629025354.624 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout 2021-08-15T11:02:34.624Z,1629025354.624 [RudderServo] Communications Fault, FailCount= 1 2021-08-15T11:02:34.624Z,1629025354.624 [RudderServo](ERROR): Communications Fault 2021-08-15T11:02:34.660Z,1629025354.660 [CBIT](ERROR): Communications Fault in component: RudderServo 2021-08-15T11:02:34.777Z,1629025354.777 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-08-15T11:02:34.777Z,1629025354.777 [RudderServo](INFO): Powering down 2021-08-15T11:02:35.621Z,1629025355.621 [RudderServo](DEBUG): Initializing EZServoServo. 2021-08-15T11:02:35.741Z,1629025355.741 [RudderServo](DEBUG): Initializing RudderServo. 2021-08-15T11:02:35.772Z,1629025355.772 [CBIT](INFO): Clearing failed state for component RudderServo 2021-08-15T11:02:35.772Z,1629025355.772 [RudderServo] No Fault, FailCount= 1 2021-08-15T11:04:02.363Z,1629025442.363 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:05:07.429Z,1629025507.429 [RDI_Pathfinder](ERROR): DVL BIT error. See manual. Result code: 100 2021-08-15T11:05:17.539Z,1629025517.539 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:05:37.321Z,1629025537.321 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T11:05:47.420Z,1629025547.420 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T11:06:37.555Z,1629025597.555 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:09:14.671Z,1629025754.671 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T11:11:02.538Z,1629025862.538 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:11:32.850Z,1629025892.850 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:11:37.710Z,1629025897.710 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T11:11:42.578Z,1629025902.578 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:11:47.800Z,1629025907.800 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:15:17.707Z,1629026117.707 [ThrusterServo](FAULT): Invalid EZ Servo response:"/0@5242" 2021-08-15T11:15:17.709Z,1629026117.709 [ThrusterServo] Communications Fault, FailCount= 1 2021-08-15T11:15:17.709Z,1629026117.709 [ThrusterServo](ERROR): Communications Fault 2021-08-15T11:15:17.729Z,1629026117.729 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2021-08-15T11:15:17.882Z,1629026117.882 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:15:18.056Z,1629026118.056 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2021-08-15T11:15:18.057Z,1629026118.057 [ThrusterServo](INFO): Powering down 2021-08-15T11:15:18.765Z,1629026118.765 [ThrusterServo](DEBUG): Initializing EZServoServo. 2021-08-15T11:15:18.885Z,1629026118.885 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2021-08-15T11:15:18.888Z,1629026118.888 [CBIT](INFO): Clearing failed state for component ThrusterServo 2021-08-15T11:15:18.889Z,1629026118.889 [ThrusterServo] No Fault, FailCount= 1 2021-08-15T11:17:51.399Z,1629026271.399 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T11:17:51.402Z,1629026271.402 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T11:20:47.964Z,1629026447.964 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,112049,COPR74 expected 46 2021-08-15T11:23:12.616Z,1629026592.616 [profile_station:NeedComms] Running Loop=1 2021-08-15T11:23:12.616Z,1629026592.616 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms 2021-08-15T11:23:12.616Z,1629026592.616 [profile_station:NeedComms:B.GoToSurface] Running Loop=1 2021-08-15T11:23:12.617Z,1629026592.617 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-08-15T11:23:12.617Z,1629026592.617 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2021-08-15T11:23:12.617Z,1629026592.617 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2021-08-15T11:23:12.618Z,1629026592.618 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2021-08-15T11:23:12.618Z,1629026592.618 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-08-15T11:23:12.618Z,1629026592.618 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-08-15T11:23:12.619Z,1629026592.619 [profile_station:NeedComms:A] Running Loop=1 2021-08-15T11:23:12.638Z,1629026592.638 [profile_station:NeedComms:A](INFO): last time_fix was: 1629015794.000000 second since 1970/01/01T00:00:00Z 2021-08-15T11:23:12.638Z,1629026592.638 [profile_station:NeedComms:A] Stopped 2021-08-15T11:23:32.855Z,1629026612.855 [profile_station:NeedComms:C] Running Loop=1 2021-08-15T11:23:33.572Z,1629026613.572 [Radio_Surface](INFO): Powering up 2021-08-15T11:23:39.564Z,1629026619.564 [DataOverHttps](INFO): Radio surface powered ON. 2021-08-15T11:23:39.657Z,1629026619.657 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:23:56.617Z,1629026636.617 [NAL9602](INFO): SBD MO Status=0, MOMSN=24027, MT Status=0, MTMSN=0 2021-08-15T11:23:56.617Z,1629026636.617 [NAL9602](INFO): No messages in MT queue 2021-08-15T11:24:03.522Z,1629026643.522 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T11:24:03.567Z,1629026643.567 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T11:24:09.689Z,1629026649.689 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T11:24:13.234Z,1629026653.234 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T11:24:23.310Z,1629026663.310 [RDI_Pathfinder](ERROR): DVL BIT error. See manual. Result code: 139 2021-08-15T11:24:24.914Z,1629026664.914 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,112426.00,A,4133.28736,N,07042.57002,W,0.233,0.00,150821,,,A*7F 2021-08-15T11:24:24.917Z,1629026664.917 [NAL9602](INFO): GPS fix at 20210815T112426: (41.554789, -70.709500) 2021-08-15T11:24:24.929Z,1629026664.929 [UniversalFixResidualReporter](INFO): Fix residual: 0.5 %DT, over the last 7333.7 m. Residual distance 34.7 m at bearing -9.7 degrees. Fix at (41.5548, -70.7095) with 229.2 m made good. 2021-08-15T11:24:24.934Z,1629026664.934 [profile_station:NeedComms:C] Stopped 2021-08-15T11:24:24.935Z,1629026664.935 [profile_station:NeedComms:D] Running Loop=1 2021-08-15T11:24:44.828Z,1629026684.828 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T11:24:50.162Z,1629026690.162 [NAL9602](INFO): SBD MO Status=2, MOMSN=24028, MT Status=2, MTMSN=0 2021-08-15T11:24:50.162Z,1629026690.162 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-15T11:25:03.355Z,1629026703.355 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T11:25:13.415Z,1629026713.415 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T11:25:17.036Z,1629026717.036 [NAL9602](INFO): SBD MO Status=1, MOMSN=24028, MT Status=0, MTMSN=0 2021-08-15T11:25:17.084Z,1629026717.084 [NAL9602](INFO): Sent 98 bytes from file Logs/20210815T051448/Courier0009.lzma 2021-08-15T11:25:17.084Z,1629026717.084 [NAL9602](INFO): Packets left to send: 0 2021-08-15T11:25:19.977Z,1629026719.977 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T11:25:25.912Z,1629026725.912 [NAL9602](INFO): SBD MO Status=1, MOMSN=24029, MT Status=0, MTMSN=0 2021-08-15T11:25:25.964Z,1629026725.964 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0010.lzma 2021-08-15T11:25:25.964Z,1629026725.964 [NAL9602](INFO): Packets left to send: 11 2021-08-15T11:25:45.907Z,1629026745.907 [NAL9602](INFO): SBD MO Status=1, MOMSN=24030, MT Status=0, MTMSN=0 2021-08-15T11:25:45.961Z,1629026745.961 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0010.lzma 2021-08-15T11:25:45.961Z,1629026745.961 [NAL9602](INFO): Packets left to send: 10 2021-08-15T11:25:55.116Z,1629026755.116 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T11:25:56.500Z,1629026756.500 [NAL9602](INFO): SBD MO Status=1, MOMSN=24031, MT Status=0, MTMSN=0 2021-08-15T11:25:56.570Z,1629026756.570 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0010.lzma 2021-08-15T11:25:56.571Z,1629026756.571 [NAL9602](INFO): Packets left to send: 9 2021-08-15T11:26:09.090Z,1629026769.090 [NAL9602](INFO): SBD MO Status=1, MOMSN=24032, MT Status=0, MTMSN=0 2021-08-15T11:26:09.138Z,1629026769.138 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0010.lzma 2021-08-15T11:26:09.139Z,1629026769.139 [NAL9602](INFO): Packets left to send: 8 2021-08-15T11:26:27.974Z,1629026787.974 [NAL9602](INFO): SBD MO Status=2, MOMSN=24033, MT Status=2, MTMSN=0 2021-08-15T11:26:27.975Z,1629026787.975 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-15T11:26:30.256Z,1629026790.256 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T11:26:31.793Z,1629026791.793 [CTD_Seabird](ERROR): Failed to parse device response: .47 2021-08-15T11:26:55.256Z,1629026815.256 [NAL9602](INFO): SBD MO Status=2, MOMSN=24033, MT Status=2, MTMSN=0 2021-08-15T11:26:55.256Z,1629026815.256 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-15T11:26:59.384Z,1629026819.384 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003117 2021-08-15T11:27:03.405Z,1629026823.405 [DataOverHttps](INFO): Sending 2061 bytes from file Logs/20210815T051448/Express0010.lzma 2021-08-15T11:27:04.402Z,1629026824.402 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Express0010.lzma.bak 2021-08-15T11:27:04.402Z,1629026824.402 [DataOverHttps](INFO): SBD MOMSN=442043 2021-08-15T11:27:06.013Z,1629026826.013 [profile_station:NeedComms:D] Stopped 2021-08-15T11:27:06.013Z,1629026826.013 [profile_station:NeedComms:E] Running Loop=1 2021-08-15T11:27:22.534Z,1629026842.534 [NAL9602](INFO): SBD MO Status=2, MOMSN=24033, MT Status=2, MTMSN=0 2021-08-15T11:27:22.534Z,1629026842.534 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-15T11:27:23.744Z,1629026843.744 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,112725.00,A,4133.28056,N,07042.57318,W,0.467,314.91,150821,,,A*7F 2021-08-15T11:27:23.747Z,1629026843.747 [NAL9602](INFO): GPS fix at 20210815T112725: (41.554676, -70.709553) 2021-08-15T11:27:23.834Z,1629026843.834 [profile_station:NeedComms:E] Stopped 2021-08-15T11:27:23.835Z,1629026843.835 [profile_station:NeedComms](INFO): Completed profile_station:NeedComms 2021-08-15T11:27:23.835Z,1629026843.835 [profile_station:NeedComms] Stopped 2021-08-15T11:27:23.835Z,1629026843.835 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms 2021-08-15T11:27:23.835Z,1629026843.835 [profile_station:NeedComms:B.GoToSurface] Stopped 2021-08-15T11:27:23.835Z,1629026843.835 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-08-15T11:27:24.591Z,1629026844.591 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch -15.00 deg, mass-position 2.95 mm. 2021-08-15T11:27:24.592Z,1629026844.592 [ElevatorOffsetCalculator](INFO): Removing expired estimator for commanded vars: speed 1.00 m/s, pitch 15.00 deg, mass-position 2.95 mm. 2021-08-15T11:27:37.300Z,1629026857.300 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T11:27:55.834Z,1629026875.834 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-15T11:28:15.771Z,1629026895.771 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch -15.00 deg, mass-position 2.95 mm (1 active estimators). 2021-08-15T11:28:45.821Z,1629026925.821 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.247440 2021-08-15T11:28:48.077Z,1629026928.077 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 15.00 deg, mass-position 2.95 mm (2 active estimators). 2021-08-15T11:29:16.308Z,1629026956.308 [Radio_Surface](INFO): Powering down 2021-08-15T11:29:21.968Z,1629026961.968 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T11:29:22.972Z,1629026962.972 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-08-15T11:30:33.574Z,1629027033.574 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:30:53.745Z,1629027053.745 [RDI_PathfinderUp](ERROR): only read 1 of 4 data items 2021-08-15T11:31:23.630Z,1629027083.630 [RDI_PathfinderUp](ERROR): only read -1 of 1 data item for altitude 2021-08-15T11:32:43.633Z,1629027163.633 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T11:35:02.929Z,1629027302.929 [CTD_Seabird](ERROR): Failed to parse device response: .50 2021-08-15T11:37:06.644Z,1629027426.644 [RDI_PathfinderUp](ERROR): DVL uart error: serial timeout 2021-08-15T11:37:06.644Z,1629027426.644 [RDI_PathfinderUp] Communications Fault, FailCount= 1 2021-08-15T11:37:06.644Z,1629027426.644 [RDI_PathfinderUp](ERROR): Communications Fault 2021-08-15T11:37:06.880Z,1629027426.880 [CBIT](ERROR): Communications Fault in component: RDI_PathfinderUp 2021-08-15T11:37:07.092Z,1629027427.092 [RDI_PathfinderUp](INFO): Powering down 2021-08-15T11:37:07.952Z,1629027427.952 [CBIT](INFO): Clearing failed state for component RDI_PathfinderUp 2021-08-15T11:37:07.952Z,1629027427.952 [RDI_PathfinderUp] No Fault, FailCount= 1 2021-08-15T11:37:45.008Z,1629027465.008 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T11:37:53.891Z,1629027473.891 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:39:34.498Z,1629027574.498 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:41:21.569Z,1629027681.569 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T11:43:39.326Z,1629027819.326 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T11:44:01.194Z,1629027841.194 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:44:09.233Z,1629027849.233 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T11:44:19.379Z,1629027859.379 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T11:44:39.214Z,1629027879.214 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T11:44:42.402Z,1629027882.402 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T11:44:59.348Z,1629027899.348 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T11:44:59.348Z,1629027899.348 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T11:44:59.348Z,1629027899.348 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T11:44:59.408Z,1629027899.408 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T11:44:59.792Z,1629027899.792 [RDI_Pathfinder](INFO): Powering down 2021-08-15T11:45:00.608Z,1629027900.608 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T11:45:00.608Z,1629027900.608 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T11:45:23.193Z,1629027923.193 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T11:45:23.193Z,1629027923.193 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T11:45:23.194Z,1629027923.194 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T11:45:23.194Z,1629027923.194 [profile_station:CircleWrapper] Stopped 2021-08-15T11:45:23.194Z,1629027923.194 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T11:45:23.194Z,1629027923.194 [profile_station:CircleWrapper:A] Stopped 2021-08-15T11:45:23.195Z,1629027923.195 [profile_station:CircleWrapper](INFO): Running loop #9 2021-08-15T11:45:23.195Z,1629027923.195 [profile_station:CircleWrapper] Running Loop=9 2021-08-15T11:45:23.195Z,1629027923.195 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T11:45:23.195Z,1629027923.195 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T11:45:23.195Z,1629027923.195 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T11:45:23.195Z,1629027923.195 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T11:47:55.133Z,1629028075.133 [CTD_Seabird](ERROR): Failed to parse device response: .01 2021-08-15T11:48:09.609Z,1629028089.609 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:48:19.410Z,1629028099.410 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:48:34.663Z,1629028114.663 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:48:44.423Z,1629028124.423 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T11:48:49.615Z,1629028129.615 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T11:48:54.464Z,1629028134.464 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T11:50:18.498Z,1629028218.498 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T11:51:59.900Z,1629028319.900 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:53:07.398Z,1629028387.398 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T11:55:10.620Z,1629028510.620 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T11:58:07.218Z,1629028687.218 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T11:59:05.061Z,1629028745.061 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T11:59:05.067Z,1629028745.067 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:00:05.172Z,1629028805.172 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T12:00:15.283Z,1629028815.283 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:00:25.033Z,1629028825.033 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T12:00:35.073Z,1629028835.073 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T12:01:15.081Z,1629028875.081 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T12:01:15.081Z,1629028875.081 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T12:01:15.081Z,1629028875.081 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T12:01:15.141Z,1629028875.141 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T12:01:15.536Z,1629028875.536 [RDI_Pathfinder](INFO): Powering down 2021-08-15T12:01:16.362Z,1629028876.362 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T12:01:16.362Z,1629028876.362 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T12:03:14.940Z,1629028994.940 [CTD_Seabird](ERROR): Failed to parse device response: 03,4806.72 2021-08-15T12:06:02.715Z,1629029162.715 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:07:15.062Z,1629029235.062 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T12:07:25.549Z,1629029245.549 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:07:28.423Z,1629029248.423 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:07:40.504Z,1629029260.504 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:07:50.620Z,1629029270.620 [RDI_PathfinderUp](ERROR): DVL uart error: serial timeout 2021-08-15T12:07:50.620Z,1629029270.620 [RDI_PathfinderUp] Communications Fault, FailCount= 1 2021-08-15T12:07:50.620Z,1629029270.620 [RDI_PathfinderUp](ERROR): Communications Fault 2021-08-15T12:07:50.738Z,1629029270.738 [CBIT](ERROR): Communications Fault in component: RDI_PathfinderUp 2021-08-15T12:07:51.100Z,1629029271.100 [RDI_PathfinderUp](INFO): Powering down 2021-08-15T12:07:51.888Z,1629029271.888 [CBIT](INFO): Clearing failed state for component RDI_PathfinderUp 2021-08-15T12:07:51.888Z,1629029271.888 [RDI_PathfinderUp] No Fault, FailCount= 1 2021-08-15T12:10:42.377Z,1629029442.377 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T12:12:20.905Z,1629029540.905 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T12:12:52.808Z,1629029572.808 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T12:13:02.905Z,1629029582.905 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:14:41.079Z,1629029681.079 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:15:00.888Z,1629029700.888 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:15:21.081Z,1629029721.081 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T12:25:15.383Z,1629030315.383 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T12:25:15.385Z,1629030315.385 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T12:26:46.346Z,1629030406.346 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:27:11.376Z,1629030431.376 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:27:16.604Z,1629030436.604 [RDI_PathfinderUp](ERROR): DVL uart error: serial timeout 2021-08-15T12:27:16.604Z,1629030436.604 [RDI_PathfinderUp] Communications Fault, FailCount= 1 2021-08-15T12:27:16.604Z,1629030436.604 [RDI_PathfinderUp](ERROR): Communications Fault 2021-08-15T12:27:16.751Z,1629030436.751 [CBIT](ERROR): Communications Fault in component: RDI_PathfinderUp 2021-08-15T12:27:17.080Z,1629030437.080 [RDI_PathfinderUp](INFO): Powering down 2021-08-15T12:27:17.864Z,1629030437.864 [CBIT](INFO): Clearing failed state for component RDI_PathfinderUp 2021-08-15T12:27:17.864Z,1629030437.864 [RDI_PathfinderUp] No Fault, FailCount= 1 2021-08-15T12:27:46.485Z,1629030466.485 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:28:12.375Z,1629030492.375 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T12:28:21.667Z,1629030501.667 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T12:28:24.473Z,1629030504.473 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:29:01.642Z,1629030541.642 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:29:20.637Z,1629030560.637 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T12:29:44.886Z,1629030584.886 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T12:30:05.500Z,1629030605.500 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T12:30:05.501Z,1629030605.501 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T12:30:05.501Z,1629030605.501 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T12:30:05.501Z,1629030605.501 [profile_station:CircleWrapper] Stopped 2021-08-15T12:30:05.501Z,1629030605.501 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T12:30:05.502Z,1629030605.502 [profile_station:CircleWrapper:A] Stopped 2021-08-15T12:30:05.502Z,1629030605.502 [profile_station:CircleWrapper](INFO): Running loop #10 2021-08-15T12:30:05.502Z,1629030605.502 [profile_station:CircleWrapper] Running Loop=10 2021-08-15T12:30:05.502Z,1629030605.502 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T12:30:05.502Z,1629030605.502 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T12:30:05.502Z,1629030605.502 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T12:30:05.502Z,1629030605.502 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T12:30:10.389Z,1629030610.389 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T12:32:21.651Z,1629030741.651 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T12:35:16.986Z,1629030916.986 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:35:36.788Z,1629030936.788 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T12:35:56.972Z,1629030956.972 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T12:36:09.113Z,1629030969.113 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T12:37:55.384Z,1629031075.384 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:38:01.863Z,1629031081.863 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:43:01.589Z,1629031381.589 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T12:43:45.342Z,1629031425.342 [CBIT](IMPORTANT): Beginning ground fault scan 2021-08-15T12:43:46.074Z,1629031426.074 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:47.078Z,1629031427.078 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:48.085Z,1629031428.085 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:49.086Z,1629031429.086 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:50.090Z,1629031430.090 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:51.096Z,1629031431.096 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:52.098Z,1629031432.098 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:53.102Z,1629031433.102 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:54.106Z,1629031434.106 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:55.110Z,1629031435.110 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:56.114Z,1629031436.114 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid. 2021-08-15T12:43:56.280Z,1629031436.280 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.004029 CHAN A1 (24V): -0.009504 CHAN A2 (12V): 0.000510 CHAN A3 (5V): 0.001172 CHAN B0 (3.3V): 0.002441 CHAN B1 (3.15aV): 0.002694 CHAN B2 (3.15bV): 0.002108 CHAN B3 (GND): 0.002244 OPEN: 0.007790 Full Scale Calc: 4.765 mA, -1.589 mA 2021-08-15T12:45:48.856Z,1629031548.856 [Micromodem](INFO): Nmea in: ROC,0.20.0.39330*7C 2021-08-15T12:45:48.856Z,1629031548.856 [Micromodem](ERROR): Response from modem failed NMEA checksum: ROC,0.20.0.39330*7C expected 0 2021-08-15T12:47:28.689Z,1629031648.689 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T12:47:47.655Z,1629031667.655 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:47:52.479Z,1629031672.479 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:47:57.370Z,1629031677.370 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T12:48:07.444Z,1629031687.444 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T12:51:28.637Z,1629031888.637 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,12512 $CAREV,125130,AUV,2.1.4000*2E expected 5A 2021-08-15T12:52:02.983Z,1629031922.983 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T12:54:53.065Z,1629032093.065 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T12:55:02.763Z,1629032102.763 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T12:55:12.879Z,1629032112.879 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T12:55:22.977Z,1629032122.977 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T12:55:33.055Z,1629032133.055 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T12:55:42.798Z,1629032142.798 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T12:56:13.055Z,1629032173.055 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T13:01:50.416Z,1629032510.416 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T13:02:56.738Z,1629032576.738 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-08-15T13:03:29.007Z,1629032609.007 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T13:04:35.261Z,1629032675.261 [CTD_Seabird](ERROR): Failed to parse device response: ,24.2515,4.79399,4778.07 2021-08-15T13:06:53.448Z,1629032813.448 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T13:07:03.539Z,1629032823.539 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T13:07:08.413Z,1629032828.413 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T13:07:23.361Z,1629032843.361 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T13:07:33.449Z,1629032853.449 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-08-15T13:12:37.360Z,1629033157.360 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-08-15T13:14:11.009Z,1629033251.009 [RDI_Pathfinder](ERROR): only read 0 of 4 data items 2021-08-15T13:14:18.744Z,1629033258.744 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T13:14:22.739Z,1629033262.739 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T13:14:28.813Z,1629033268.813 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T13:14:38.902Z,1629033278.902 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T13:14:40.913Z,1629033280.913 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-08-15T13:15:11.226Z,1629033311.226 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T13:15:11.226Z,1629033311.226 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T13:15:11.227Z,1629033311.227 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper 2021-08-15T13:15:11.227Z,1629033311.227 [profile_station:CircleWrapper] Stopped 2021-08-15T13:15:11.227Z,1629033311.227 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T13:15:11.227Z,1629033311.227 [profile_station:CircleWrapper:A] Stopped 2021-08-15T13:15:11.227Z,1629033311.227 [profile_station:CircleWrapper](INFO): Running loop #11 2021-08-15T13:15:11.228Z,1629033311.228 [profile_station:CircleWrapper] Running Loop=11 2021-08-15T13:15:11.228Z,1629033311.228 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-08-15T13:15:11.228Z,1629033311.228 [profile_station:CircleWrapper:A] Running Loop=1 2021-08-15T13:15:11.228Z,1629033311.228 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-08-15T13:15:11.228Z,1629033311.228 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-08-15T13:15:38.766Z,1629033338.766 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-08-15T13:16:14.716Z,1629033374.716 [profile_station](INFO): Timed out from 2021-08-15T05:16:14.6Z 2021-08-15T13:16:14.716Z,1629033374.716 [MissionManager](INFO): profile_station is completed. 2021-08-15T13:16:14.717Z,1629033374.717 [MissionManager](INFO): Uninitializing Mission profile_station 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station] Stopped 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station](DEBUG): Aggregate::uninitialize profile_station 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station:Science] Stopped 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station:Science](DEBUG): Aggregate::uninitialize profile_station:Science 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station:Science:B] Stopped 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station:Science:C] Stopped 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station:Science:E] Stopped 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station:Science:Read_Oil] Stopped 2021-08-15T13:16:14.717Z,1629033374.717 [profile_station:Science:OceanCurrent] Stopped 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:Science:OceanCurrent](DEBUG): Aggregate::uninitialize profile_station:Science:OceanCurrent 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:Science:OceanCurrent:A.] Stopped 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:Science:PeakDetectChl] Stopped 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectChl 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:StandardEnvelopes] Stopped 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:StandardEnvelopes](DEBUG): Aggregate::uninitialize profile_station:StandardEnvelopes 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-08-15T13:16:14.718Z,1629033374.718 [profile_station:StandardEnvelopes:B.DepthEnvelope] Stopped 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:I.Pitch] Stopped 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:J.Buoyancy] Stopped 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:K.SetSpeed] Stopped 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:K.SetSpeed](DEBUG): Uninitialize. 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:L.DepthEnvelope] Stopped 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:L.DepthEnvelope](DEBUG): Uninitialize. 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:M.AltitudeEnvelope] Stopped 2021-08-15T13:16:14.719Z,1629033374.719 [profile_station:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-08-15T13:16:14.720Z,1629033374.720 [profile_station:N.YoYo] Stopped 2021-08-15T13:16:14.720Z,1629033374.720 [profile_station:N.YoYo](DEBUG): Uninitialize YoYoComponent. 2021-08-15T13:16:14.720Z,1629033374.720 [profile_station:CircleWrapper] Stopped 2021-08-15T13:16:14.720Z,1629033374.720 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-08-15T13:16:14.720Z,1629033374.720 [profile_station:CircleWrapper:A] Stopped 2021-08-15T13:16:14.720Z,1629033374.720 [profile_station:CircleWrapper:B.Circle] Stopped 2021-08-15T13:16:14.720Z,1629033374.720 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-08-15T13:16:15.076Z,1629033375.076 [WetLabsSeaOWL_UV_A](INFO): Powering down 2021-08-15T13:16:15.081Z,1629033375.081 [MissionManager](IMPORTANT): Started mission DefaultWithUndock 2021-08-15T13:16:15.081Z,1629033375.081 [DefaultWithUndock] Running Loop=1 2021-08-15T13:16:15.081Z,1629033375.081 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock 2021-08-15T13:16:15.081Z,1629033375.081 [DefaultWithUndock:A.Wait] Running Loop=1 2021-08-15T13:16:15.082Z,1629033375.082 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component. 2021-08-15T13:16:45.354Z,1629033405.354 [DefaultWithUndock:A.Wait](INFO): Done Waiting. 2021-08-15T13:16:45.355Z,1629033405.355 [DefaultWithUndock:A.Wait] Stopped 2021-08-15T13:16:45.355Z,1629033405.355 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component. 2021-08-15T13:16:45.356Z,1629033405.356 [DefaultWithUndock:LeaveDock] Running Loop=1 2021-08-15T13:16:45.357Z,1629033405.357 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock 2021-08-15T13:16:45.357Z,1629033405.357 [DefaultWithUndock:LeaveDock:A.] Running Loop=1 2021-08-15T13:16:45.357Z,1629033405.357 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact. 2021-08-15T13:16:45.358Z,1629033405.358 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1 2021-08-15T13:16:45.358Z,1629033405.358 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize. 2021-08-15T13:16:45.359Z,1629033405.359 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values. 2021-08-15T13:16:46.143Z,1629033406.143 [PowerOnly](INFO): Powering up loadControl 2021-08-15T13:16:48.216Z,1629033408.216 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-08-15T13:16:48.630Z,1629033408.630 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2021-08-15T13:16:48.630Z,1629033408.630 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2021-08-15T13:16:48.630Z,1629033408.630 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 75 2021-08-15T13:16:48.631Z,1629033408.631 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2021-08-15T13:16:48.723Z,1629033408.723 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock. 2021-08-15T13:16:49.009Z,1629033409.009 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P 80,80,63,E4 B,187,80,80,5E,FF 2021-08-15T13:16:49.009Z,1629033409.009 [DUSBL_Hydroid](INFO): Command Ack 2021-08-15T13:16:49.009Z,1629033409.009 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2021-08-15T13:16:49.012Z,1629033409.012 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-08-15T13:16:49.149Z,1629033409.149 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Engaging thruster for 10.0 seconds (max) to disengage. 2021-08-15T13:16:49.438Z,1629033409.438 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-08-15T13:16:50.233Z,1629033410.233 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,E1D,000,016DC,186,80,80,84,FF 2021-08-15T13:16:50.233Z,1629033410.233 [DUSBL_Hydroid](INFO): publishing direction and range info 2021-08-15T13:16:50.257Z,1629033410.257 [Micromodem](INFO): Nmea in: $SNTTA,,,,,131650.87*51 2021-08-15T13:16:50.720Z,1629033410.720 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Thruster off. 2021-08-15T13:16:51.067Z,1629033411.067 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer. 2021-08-15T13:16:53.083Z,1629033413.083 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-08-15T13:16:53.445Z,1629033413.445 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2021-08-15T13:16:53.445Z,1629033413.445 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2021-08-15T13:16:53.445Z,1629033413.445 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 75 2021-08-15T13:16:53.446Z,1629033413.446 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2021-08-15T13:16:53.857Z,1629033413.857 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P E1D,000,016DC,186,80,80,84,FF 2021-08-15T13:16:53.857Z,1629033413.857 [DUSBL_Hydroid](INFO): Command Ack 2021-08-15T13:16:53.857Z,1629033413.857 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2021-08-15T13:16:53.859Z,1629033413.859 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-08-15T13:16:54.256Z,1629033414.256 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-08-15T13:16:55.085Z,1629033415.085 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,EBA,000,016DF,186,80,80,81,FF 2021-08-15T13:16:55.085Z,1629033415.085 [DUSBL_Hydroid](INFO): publishing direction and range info 2021-08-15T13:16:55.088Z,1629033415.088 [Micromodem](INFO): Nmea in: $SNTTA,,,,,131655.72*5E 2021-08-15T13:16:57.905Z,1629033417.905 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-08-15T13:16:58.305Z,1629033418.305 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2021-08-15T13:16:58.305Z,1629033418.305 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2021-08-15T13:16:58.306Z,1629033418.306 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 75 2021-08-15T13:16:58.306Z,1629033418.306 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2021-08-15T13:16:58.741Z,1629033418.741 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P EBA,000,016DF,186,80,80,81,FF 2021-08-15T13:16:58.741Z,1629033418.741 [DUSBL_Hydroid](INFO): Command Ack 2021-08-15T13:16:58.742Z,1629033418.742 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2021-08-15T13:16:58.743Z,1629033418.743 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-08-15T13:16:59.113Z,1629033419.113 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-08-15T13:16:59.921Z,1629033419.921 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,F45,000,016E1,186,80,80,72,FF 2021-08-15T13:16:59.922Z,1629033419.922 [DUSBL_Hydroid](INFO): publishing direction and range info 2021-08-15T13:16:59.926Z,1629033419.926 [Micromodem](INFO): Nmea in: $SNTTA,,,,,131700.61*5D 2021-08-15T13:17:02.796Z,1629033422.796 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-08-15T13:17:03.149Z,1629033423.149 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2021-08-15T13:17:03.149Z,1629033423.149 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2021-08-15T13:17:03.149Z,1629033423.149 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 75 2021-08-15T13:17:03.150Z,1629033423.150 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2021-08-15T13:17:03.562Z,1629033423.562 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P F45,000,016E1,186,80,80,72,FF 2021-08-15T13:17:03.562Z,1629033423.562 [DUSBL_Hydroid](INFO): Command Ack 2021-08-15T13:17:03.562Z,1629033423.562 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2021-08-15T13:17:03.564Z,1629033423.564 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-08-15T13:17:03.960Z,1629033423.960 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-08-15T13:17:04.773Z,1629033424.773 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,BB7,000,016DB,189,80,80,3F,FF 2021-08-15T13:17:04.773Z,1629033424.773 [DUSBL_Hydroid](INFO): publishing direction and range info 2021-08-15T13:17:04.776Z,1629033424.776 [Micromodem](INFO): Nmea in: $SNTTA,,,,,131705.42*59 2021-08-15T13:17:07.619Z,1629033427.619 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-08-15T13:17:07.997Z,1629033427.997 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2021-08-15T13:17:07.997Z,1629033427.997 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2021-08-15T13:17:07.997Z,1629033427.997 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 75 2021-08-15T13:17:07.998Z,1629033427.998 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2021-08-15T13:17:08.421Z,1629033428.421 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P BB7,000,016DB,189,80,80,3F,FF 2021-08-15T13:17:08.421Z,1629033428.421 [DUSBL_Hydroid](INFO): Command Ack 2021-08-15T13:17:08.421Z,1629033428.421 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2021-08-15T13:17:08.423Z,1629033428.423 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-08-15T13:17:08.836Z,1629033428.836 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-08-15T13:17:09.618Z,1629033429.618 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,R,039,000,016DD,184,80,80,40,FF 2021-08-15T13:17:09.619Z,1629033429.619 [DUSBL_Hydroid](INFO): publishing direction and range info 2021-08-15T13:17:09.623Z,1629033429.623 [Micromodem](INFO): Nmea in: $SNTTA,,,,,131710.28*51 2021-08-15T13:17:11.259Z,1629033431.259 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: 313.68 m. Transitioning DDM to standby. 2021-08-15T13:17:12.490Z,1629033432.490 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact *** 2021-08-15T13:17:12.845Z,1629033432.845 [DUSBL_Hydroid](INFO): ****** received transponder code query ****** 2021-08-15T13:17:12.845Z,1629033432.845 [DUSBL_Hydroid](INFO): ****** received ping request ****** 2021-08-15T13:17:12.845Z,1629033432.845 [DUSBL_Hydroid](INFO): Arming DUSBL. detectThresh: 75 2021-08-15T13:17:12.846Z,1629033432.846 [DUSBL_Hydroid](INFO): ****** ping requested ****** 2021-08-15T13:17:13.245Z,1629033433.245 [DUSBL_Hydroid](INFO): DUSBL response received:!U1,P 039,000,016DD,184,80,80,40,FF 2021-08-15T13:17:13.245Z,1629033433.245 [DUSBL_Hydroid](INFO): Command Ack 2021-08-15T13:17:13.246Z,1629033433.246 [DUSBL_Hydroid](INFO): Requesting micromodem ping code 2 2021-08-15T13:17:13.247Z,1629033433.247 [Micromodem](INFO): Nmea out: $CCPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*76 2021-08-15T13:17:13.683Z,1629033433.683 [Micromodem](INFO): Nmea in: $SNPGT,1,14500,40,0,1000,24000,28,4A1C0370,6C8F7D30,2107E320,37BCD1E0,4000,4000,0*6B 2021-08-15T13:17:13.717Z,1629033433.717 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby. 2021-08-15T13:17:14.073Z,1629033434.073 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete. 2021-08-15T13:17:14.073Z,1629033434.073 [DefaultWithUndock:LeaveDock:B.Undock] Stopped 2021-08-15T13:17:14.074Z,1629033434.074 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock 2021-08-15T13:17:14.074Z,1629033434.074 [DefaultWithUndock:LeaveDock] Stopped 2021-08-15T13:17:14.074Z,1629033434.074 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock 2021-08-15T13:17:14.074Z,1629033434.074 [DefaultWithUndock:LeaveDock:A.] Stopped 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault] Running Loop=1 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1 2021-08-15T13:17:14.075Z,1629033434.075 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-08-15T13:17:14.076Z,1629033434.076 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-08-15T13:17:14.076Z,1629033434.076 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-08-15T13:17:14.076Z,1629033434.076 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-08-15T13:17:14.077Z,1629033434.077 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-08-15T13:17:14.077Z,1629033434.077 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-08-15T13:17:14.448Z,1629033434.448 [Micromodem](INFO): Nmea in: $SNTTA,,,,,131715.11*5E 2021-08-15T13:17:14.903Z,1629033434.903 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -26.00 mm (3 active estimators). 2021-08-15T13:17:15.136Z,1629033435.136 [Radio_Surface](INFO): Powering up 2021-08-15T13:17:18.988Z,1629033438.988 [DDM](ERROR): Could not parse whisker state 2021-08-15T13:17:20.752Z,1629033440.752 [DataOverHttps](INFO): Radio surface powered ON. 2021-08-15T13:17:41.585Z,1629033461.585 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1 2021-08-15T13:17:41.585Z,1629033461.585 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T13:17:41.585Z,1629033461.585 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-08-15T13:17:41.585Z,1629033461.585 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped 2021-08-15T13:17:41.585Z,1629033461.585 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen 2021-08-15T13:17:41.585Z,1629033461.585 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped 2021-08-15T13:17:41.585Z,1629033461.585 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped 2021-08-15T13:17:48.889Z,1629033468.889 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-08-15T13:17:50.876Z,1629033470.876 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T13:18:17.455Z,1629033497.455 [PowerOnly](INFO): Powering down loadControl 2021-08-15T13:18:26.025Z,1629033506.025 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T13:18:29.186Z,1629033509.186 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T13:18:40.495Z,1629033520.495 [NAL9602](INFO): SBD MO Status=1, MOMSN=24033, MT Status=0, MTMSN=0 2021-08-15T13:18:40.495Z,1629033520.495 [NAL9602](INFO): No messages in MT queue 2021-08-15T13:18:41.704Z,1629033521.704 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,131843.00,A,4133.17754,N,07042.20737,W,1.089,63.63,150821,,,A*4A 2021-08-15T13:18:41.707Z,1629033521.707 [NAL9602](INFO): GPS fix at 20210815T131843: (41.552959, -70.703456) 2021-08-15T13:18:41.730Z,1629033521.730 [UniversalFixResidualReporter](INFO): Fix residual: 0.4 %DT, over the last 4572.2 m. Residual distance 16.9 m at bearing -36.0 degrees. Fix at (41.5530, -70.7035) with 542.1 m made good. 2021-08-15T13:18:41.731Z,1629033521.731 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-08-15T13:18:41.731Z,1629033521.731 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-08-15T13:18:51.534Z,1629033531.534 [NAL9602](INFO): SBD MO Status=1, MOMSN=24034, MT Status=0, MTMSN=0 2021-08-15T13:18:51.584Z,1629033531.584 [NAL9602](INFO): Sent 90 bytes from file Logs/20210815T051448/Courier0012.lzma 2021-08-15T13:18:51.584Z,1629033531.584 [NAL9602](INFO): Packets left to send: 0 2021-08-15T13:18:59.232Z,1629033539.232 [NAL9602](INFO): SBD MO Status=1, MOMSN=24035, MT Status=0, MTMSN=0 2021-08-15T13:18:59.284Z,1629033539.284 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:18:59.284Z,1629033539.284 [NAL9602](INFO): Packets left to send: 8 2021-08-15T13:19:01.164Z,1629033541.164 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T13:19:07.833Z,1629033547.833 [NAL9602](INFO): SBD MO Status=1, MOMSN=24036, MT Status=0, MTMSN=0 2021-08-15T13:19:07.884Z,1629033547.884 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:19:07.884Z,1629033547.884 [NAL9602](INFO): Packets left to send: 7 2021-08-15T13:19:20.882Z,1629033560.882 [NAL9602](INFO): SBD MO Status=1, MOMSN=24037, MT Status=0, MTMSN=0 2021-08-15T13:19:20.935Z,1629033560.935 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:19:20.935Z,1629033560.935 [NAL9602](INFO): Packets left to send: 6 2021-08-15T13:19:32.243Z,1629033572.243 [NAL9602](INFO): SBD MO Status=1, MOMSN=24038, MT Status=0, MTMSN=0 2021-08-15T13:19:32.304Z,1629033572.304 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:19:32.304Z,1629033572.304 [NAL9602](INFO): Packets left to send: 5 2021-08-15T13:19:36.308Z,1629033576.308 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T13:19:40.997Z,1629033580.997 [NAL9602](INFO): SBD MO Status=1, MOMSN=24039, MT Status=0, MTMSN=0 2021-08-15T13:19:41.048Z,1629033581.048 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:19:41.048Z,1629033581.048 [NAL9602](INFO): Packets left to send: 4 2021-08-15T13:19:48.322Z,1629033588.322 [NAL9602](INFO): SBD MO Status=1, MOMSN=24040, MT Status=0, MTMSN=0 2021-08-15T13:19:48.372Z,1629033588.372 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:19:48.372Z,1629033588.372 [NAL9602](INFO): Packets left to send: 3 2021-08-15T13:19:59.276Z,1629033599.276 [NAL9602](INFO): SBD MO Status=1, MOMSN=24041, MT Status=0, MTMSN=0 2021-08-15T13:19:59.325Z,1629033599.325 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:19:59.325Z,1629033599.325 [NAL9602](INFO): Packets left to send: 2 2021-08-15T13:20:09.070Z,1629033609.070 [NAL9602](INFO): SBD MO Status=1, MOMSN=24042, MT Status=0, MTMSN=0 2021-08-15T13:20:09.124Z,1629033609.124 [NAL9602](INFO): Sent 184 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:20:09.124Z,1629033609.124 [NAL9602](INFO): Packets left to send: 1 2021-08-15T13:20:11.464Z,1629033611.464 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-08-15T13:20:17.154Z,1629033617.154 [NAL9602](INFO): SBD MO Status=1, MOMSN=24043, MT Status=0, MTMSN=0 2021-08-15T13:20:17.204Z,1629033617.204 [NAL9602](INFO): Sent 48 bytes from file Logs/20210815T051448/Express0013.lzma 2021-08-15T13:20:17.204Z,1629033617.204 [NAL9602](INFO): Packets left to send: 0 2021-08-15T13:20:24.116Z,1629033624.116 [NAL9602](INFO): SBD MO Status=0, MOMSN=24044, MT Status=0, MTMSN=0 2021-08-15T13:20:35.185Z,1629033635.185 [NAL9602](INFO): SBD MO Status=0, MOMSN=24045, MT Status=0, MTMSN=0 2021-08-15T13:20:40.584Z,1629033640.584 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003152 2021-08-15T13:20:42.199Z,1629033642.199 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-08-15T13:20:42.199Z,1629033642.199 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-08-15T13:20:42.199Z,1629033642.199 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-15T13:20:54.299Z,1629033654.299 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-08-15T13:20:56.723Z,1629033656.723 [NAL9602](INFO): SBD MO Status=2, MOMSN=24046, MT Status=2, MTMSN=0 2021-08-15T13:20:56.724Z,1629033656.724 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-08-15T13:21:27.418Z,1629033687.418 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-15T13:23:07.213Z,1629033787.213 [DataOverHttps](IMPORTANT): SBD MTMSN=20210815T132308 2021-08-15T13:23:11.233Z,1629033791.233 [DataOverHttps](INFO): Received command:get LineCapture.rolloutTimeout 2021-08-15T13:23:12.578Z,1629033792.578 [CommandLine](IMPORTANT): got command get LineCapture.rolloutTimeout 2021-08-15T13:23:12.579Z,1629033792.579 [CommandLine](IMPORTANT): LineCapture.rolloutTimeout 7.000000 min 2021-08-15T13:23:12.582Z,1629033792.582 [DataOverHttps](IMPORTANT): SBD MTMSN=20210815T132313 2021-08-15T13:23:16.600Z,1629033796.600 [DataOverHttps](INFO): Received command:get LineCapture.navigationGain 2021-08-15T13:23:18.318Z,1629033798.318 [CommandLine](IMPORTANT): got command get LineCapture.navigationGain 2021-08-15T13:23:18.319Z,1629033798.319 [CommandLine](IMPORTANT): LineCapture.navigationGain 4.000000 n/a 2021-08-15T13:23:18.326Z,1629033798.326 [DataOverHttps](IMPORTANT): SBD MTMSN=20210815T132319 2021-08-15T13:23:22.346Z,1629033802.346 [DataOverHttps](INFO): Received command:get LineCapture.rolloutSpeed 2021-08-15T13:23:24.542Z,1629033804.542 [CommandLine](IMPORTANT): got command get LineCapture.rolloutSpeed 2021-08-15T13:23:24.543Z,1629033804.543 [CommandLine](IMPORTANT): LineCapture.rolloutSpeed 1.000000 m/s 2021-08-15T13:25:15.338Z,1629033915.338 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T13:25:15.343Z,1629033915.343 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815132516.416855,06,1754,26,0111,0150,134,03,03,01,03,-1,-01,-01,1,3,1,0,150,16.7,0.47,-100,2.53,-01,-4.80,53,14500,4000*50 2021-08-15T13:25:42.876Z,1629033942.876 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-15T13:25:42.876Z,1629033942.876 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-08-15T13:25:42.877Z,1629033942.877 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-15T13:25:42.877Z,1629033942.877 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1 2021-08-15T13:25:43.201Z,1629033943.201 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped 2021-08-15T13:25:43.201Z,1629033943.201 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1 2021-08-15T13:25:43.605Z,1629033943.605 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 9.468664 min 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T13:25:43.606Z,1629033943.606 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-08-15T13:25:45.629Z,1629033945.629 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,132547.00,A,4133.16348,N,07042.22138,W,0.525,169.67,150821,,,A*7E 2021-08-15T13:25:45.631Z,1629033945.631 [NAL9602](INFO): GPS fix at 20210815T132547: (41.552725, -70.703690) 2021-08-15T13:25:45.642Z,1629033945.642 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-08-15T13:25:45.642Z,1629033945.642 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-08-15T13:25:49.147Z,1629033949.147 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210815T051448/Courier0015.lzma 2021-08-15T13:25:50.150Z,1629033950.150 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Courier0015.lzma.bak 2021-08-15T13:25:50.150Z,1629033950.150 [DataOverHttps](INFO): SBD MOMSN=442417 2021-08-15T13:25:59.187Z,1629033959.187 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210815T051448/Courier0016.lzma 2021-08-15T13:26:00.190Z,1629033960.190 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Courier0016.lzma.bak 2021-08-15T13:26:00.190Z,1629033960.190 [DataOverHttps](INFO): SBD MOMSN=442420 2021-08-15T13:26:00.701Z,1629033960.701 [Micromodem](INFO): Nmea in: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error 2021-08-15T13:26:00.702Z,1629033960.702 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CATRC,RECV,COP , 213,COPROC_par_read_parobj: size error expected 41 2021-08-15T13:26:00.707Z,1629033960.707 [NAL9602](INFO): SBD MO Status=0, MOMSN=24046, MT Status=0, MTMSN=0 2021-08-15T13:26:00.707Z,1629033960.707 [NAL9602](INFO): No messages in MT queue 2021-08-15T13:26:01.063Z,1629033961.063 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T13:26:01.474Z,1629033961.474 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815132600.432431,06,185,22,0094,0150,134,02,02,00,02,-1,-01,-01,1,3,3,0,150,76.5,-347.74,-100,-304.62,-01,0.00,-12,14500,4000*67 2021-08-15T13:26:09.229Z,1629033969.229 [DataOverHttps](INFO): Sending 335 bytes from file Logs/20210815T051448/Express0016.lzma 2021-08-15T13:26:10.230Z,1629033970.230 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Express0016.lzma.bak 2021-08-15T13:26:10.230Z,1629033970.230 [DataOverHttps](INFO): SBD MOMSN=442422 2021-08-15T13:26:11.995Z,1629033971.995 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-08-15T13:26:11.995Z,1629033971.995 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-08-15T13:26:11.995Z,1629033971.995 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-15T13:26:31.084Z,1629033991.084 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-15T13:28:35.523Z,1629034115.523 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T13:28:35.542Z,1629034115.542 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815132836.430865,06,592,21,0209,0150,208,02,02,01,02,-1,-01,-01,1,3,6,0,150,9.8,-0.07,-100,3.07,-01,-1.01,64,14500,4000*76 2021-08-15T13:29:07.449Z,1629034147.449 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T13:29:07.454Z,1629034147.454 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815132908.433685,06,445,20,0106,0150,223,02,02,01,02,-1,-01,-01,1,3,1,0,150,7.5,0.00,-100,3.00,-01,0.19,66,14500,4000*78 2021-08-15T13:30:17.338Z,1629034217.338 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T13:30:17.344Z,1629034217.344 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815133018.433510,06,1929,26,0208,0150,208,02,02,01,02,-1,-01,-01,1,3,1,0,150,4.4,0.16,-100,2.84,-01,-0.77,68,14500,4000*69 2021-08-15T13:31:12.726Z,1629034272.726 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting. 2021-08-15T13:31:12.726Z,1629034272.726 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped 2021-08-15T13:31:12.726Z,1629034272.726 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-08-15T13:31:12.727Z,1629034272.727 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1 2021-08-15T13:31:13.087Z,1629034273.087 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped 2021-08-15T13:31:13.087Z,1629034273.087 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1 2021-08-15T13:31:13.503Z,1629034273.503 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 14.966765 min 2021-08-15T13:31:13.503Z,1629034273.503 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped 2021-08-15T13:31:13.503Z,1629034273.503 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T13:31:13.503Z,1629034273.503 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped 2021-08-15T13:31:13.503Z,1629034273.503 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T13:31:13.503Z,1629034273.503 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #3 2021-08-15T13:31:13.504Z,1629034273.504 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=3 2021-08-15T13:31:13.504Z,1629034273.504 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn 2021-08-15T13:31:13.504Z,1629034273.504 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1 2021-08-15T13:31:15.501Z,1629034275.501 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,133117.00,A,4133.15083,N,07042.23449,W,0.058,227.88,150821,,,D*79 2021-08-15T13:31:15.517Z,1629034275.517 [NAL9602](INFO): GPS fix at 20210815T133117: (41.552514, -70.703908) 2021-08-15T13:31:15.527Z,1629034275.527 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped 2021-08-15T13:31:15.527Z,1629034275.527 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1 2021-08-15T13:31:19.559Z,1629034279.559 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20210815T051448/Courier0019.lzma 2021-08-15T13:31:20.562Z,1629034280.562 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Courier0019.lzma.bak 2021-08-15T13:31:20.562Z,1629034280.562 [DataOverHttps](INFO): SBD MOMSN=442458 2021-08-15T13:31:29.604Z,1629034289.604 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20210815T051448/Express0020.lzma 2021-08-15T13:31:30.606Z,1629034290.606 [DataOverHttps](INFO): Moved sent file to Logs/20210815T051448/Express0020.lzma.bak 2021-08-15T13:31:30.606Z,1629034290.606 [DataOverHttps](INFO): SBD MOMSN=442461 2021-08-15T13:31:32.503Z,1629034292.503 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped 2021-08-15T13:31:32.503Z,1629034292.503 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1 2021-08-15T13:31:32.503Z,1629034292.503 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-08-15T13:31:39.750Z,1629034299.750 [NAL9602](INFO): SBD MO Status=0, MOMSN=24047, MT Status=0, MTMSN=0 2021-08-15T13:31:39.750Z,1629034299.750 [NAL9602](INFO): No messages in MT queue 2021-08-15T13:32:10.443Z,1629034330.443 [NAL9602](INFO): Not Powering down - fast GPS 2021-08-15T13:32:37.921Z,1629034357.921 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-08-15T13:32:37.924Z,1629034357.924 [BPC1](INFO): Received data from all battery sticks. 2021-08-15T13:33:43.375Z,1629034423.375 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T13:33:43.380Z,1629034423.380 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815133344.431601,06,103,20,0168,0150,149,02,02,00,02,-1,-01,-01,1,3,6,0,150,17.1,-0.01,-100,3.01,-01,-0.05,57,14500,4000*49 2021-08-15T13:33:44.238Z,1629034424.238 [CommandLine](IMPORTANT): got command get LineCapture.rolloutDistance 2021-08-15T13:33:44.238Z,1629034424.238 [CommandLine](IMPORTANT): LineCapture.rolloutDistance 2000.000000 m 2021-08-15T13:33:45.000Z,1629034425.000 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. 2021-08-15T13:33:57.196Z,1629034437.196 [CommandLine](IMPORTANT): got command get LineCapture.rolloutSpeed 2021-08-15T13:33:57.197Z,1629034437.197 [CommandLine](IMPORTANT): LineCapture.rolloutSpeed 1.000000 m/s 2021-08-15T13:34:08.690Z,1629034448.690 [CommandLine](IMPORTANT): got command get LineCapture.navigationGain 2021-08-15T13:34:08.691Z,1629034448.691 [CommandLine](IMPORTANT): LineCapture.navigationGain 4.000000 n/a 2021-08-15T13:34:19.995Z,1629034459.995 [CommandLine](IMPORTANT): got command get LineCapture.rolloutTimeout 2021-08-15T13:34:20.002Z,1629034460.002 [CommandLine](IMPORTANT): LineCapture.rolloutTimeout 7.000000 min 2021-08-15T13:34:34.738Z,1629034474.738 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-08-15T13:34:34.738Z,1629034474.738 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-08-15T13:34:34.738Z,1629034474.738 [RDI_Pathfinder](ERROR): Communications Fault 2021-08-15T13:34:34.764Z,1629034474.764 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-08-15T13:34:35.152Z,1629034475.152 [RDI_Pathfinder](INFO): Powering down 2021-08-15T13:34:35.920Z,1629034475.920 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-08-15T13:34:35.920Z,1629034475.920 [RDI_Pathfinder] No Fault, FailCount= 1 2021-08-15T13:35:07.003Z,1629034507.003 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-08-15T13:35:07.431Z,1629034507.431 [Micromodem](INFO): Nmea in: $CACST,6,1,20210815133508.140754,06,193,22,0090,0150,141,00,00,00,00,-1,-01,-01,1,3,1,0,150,21.7,0.50,-100,2.50,-01,-0.04,64,14500,4000*6B 2021-08-15T13:35:08.489Z,1629034508.489 [DataOverHttps](IMPORTANT): SBD MTMSN=20210815T133509 2021-08-15T13:35:12.507Z,1629034512.507 [DataOverHttps](INFO): Received command:restart logs