2021-11-17T17:43:45.097Z,1637171025.097 [CommandExec](IMPORTANT): got command restart logs 2021-11-17T17:44:33.228Z,1637171073.228 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-11-17T17:43:33.0Z 2021-11-17T17:44:33.228Z,1637171073.228 [Default:CheckIn:Read_GPS] Stopped 2021-11-17T17:44:33.228Z,1637171073.228 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-11-17T17:44:34.794Z,1637171074.794 [DAT](INFO): #Outgoing data=1 2021-11-17T17:44:34.794Z,1637171074.794 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2021-11-17T17:44:34.894Z,1637171074.894 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2021-11-17T17:44:38.482Z,1637171078.482 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:44:03.1208 2021-11-17T17:44:38.482Z,1637171078.482 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2021-11-17T17:44:40.399Z,1637171080.399 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20211117T060617/Courier0822.lzma 2021-11-17T17:44:41.402Z,1637171081.402 [DataOverHttps](INFO): Moved sent file to Logs/20211117T060617/Courier0822.lzma.bak 2021-11-17T17:44:41.402Z,1637171081.402 [DataOverHttps](INFO): SBD MOMSN=16261799 2021-11-17T17:44:48.581Z,1637171088.581 [DAT](FAULT): Ack receipt timeout failure. 2021-11-17T17:44:48.582Z,1637171088.582 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED 2021-11-17T17:44:48.992Z,1637171088.992 [DAT](INFO): Sent 39 bytes from file Logs/20211117T060617/Courier0822.lzma.parts 2021-11-17T17:44:48.992Z,1637171088.992 [DAT](INFO): Packets left to send: 0 2021-11-17T17:44:48.994Z,1637171088.994 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER 2021-11-17T17:44:49.856Z,1637171089.856 [DAT](INFO): #Outgoing data=1 2021-11-17T17:44:49.856Z,1637171089.856 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2021-11-17T17:44:49.943Z,1637171089.943 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2021-11-17T17:44:53.554Z,1637171093.554 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:44:18.2707 2021-11-17T17:44:53.554Z,1637171093.554 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2021-11-17T17:44:57.355Z,1637171097.355 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20211117T174345/Courier0000.lzma 2021-11-17T17:44:58.357Z,1637171098.357 [DataOverHttps](INFO): Moved sent file to Logs/20211117T174345/Courier0000.lzma.bak 2021-11-17T17:44:58.357Z,1637171098.357 [DataOverHttps](INFO): SBD MOMSN=16261802 2021-11-17T17:45:03.653Z,1637171103.653 [DAT](FAULT): Ack receipt timeout failure. 2021-11-17T17:45:03.653Z,1637171103.653 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED 2021-11-17T17:45:04.057Z,1637171104.057 [DAT](INFO): Sent 151 bytes from file Logs/20211117T174345/Courier0000.lzma.parts 2021-11-17T17:45:04.058Z,1637171104.058 [DAT](INFO): Packets left to send: 0 2021-11-17T17:45:04.060Z,1637171104.060 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER 2021-11-17T17:45:05.384Z,1637171105.384 [NAL9602](INFO): Not Powering down - fast GPS 2021-11-17T17:45:15.992Z,1637171115.992 [DataOverHttps](INFO): Sending 329 bytes from file Logs/20211117T060617/Express0823.lzma 2021-11-17T17:45:16.994Z,1637171116.994 [DataOverHttps](INFO): Moved sent file to Logs/20211117T060617/Express0823.lzma.bak 2021-11-17T17:45:16.994Z,1637171116.994 [DataOverHttps](INFO): SBD MOMSN=16261805 2021-11-17T17:45:39.519Z,1637171139.519 [DataOverHttps](INFO): Sending 258 bytes from file Logs/20211117T174345/Express0001.lzma 2021-11-17T17:45:40.521Z,1637171140.521 [DataOverHttps](INFO): Moved sent file to Logs/20211117T174345/Express0001.lzma.bak 2021-11-17T17:45:40.522Z,1637171140.522 [DataOverHttps](INFO): SBD MOMSN=16261814 2021-11-17T17:45:43.975Z,1637171143.975 [Default:CheckIn:Read_Iridium] Stopped 2021-11-17T17:45:43.975Z,1637171143.975 [Default:CheckIn:C.Wait] Running Loop=1 2021-11-17T17:45:43.975Z,1637171143.975 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-11-17T17:45:51.233Z,1637171151.233 [DataOverHttps](IMPORTANT): SBD MTMSN=20211117T174550 2021-11-17T17:45:58.660Z,1637171158.660 [DataOverHttps](INFO): Received command: run Maintenance/tank_ballast_and_trim.xml 2021-11-17T17:45:58.718Z,1637171158.718 [CommandExec](IMPORTANT): got command run ./Missions/Maintenance/tank_ballast_and_trim.xml 2021-11-17T17:45:58.724Z,1637171158.724 [MissionManager](INFO): Loading Mission: ./Missions/Maintenance/tank_ballast_and_trim.xml 2021-11-17T17:45:58.810Z,1637171158.810 [MissionManager](INFO): DefineArg ballast_and_trim.MissionTimeout = 120.000000 min 2021-11-17T17:45:58.832Z,1637171158.832 [MissionManager](INFO): DefineArg ballast_and_trim.SkipComms = 0 bool 2021-11-17T17:45:58.835Z,1637171158.835 [MissionManager](INFO): DefineArg ballast_and_trim.Depth1 = 7.000000 m 2021-11-17T17:45:58.839Z,1637171158.839 [MissionManager](INFO): DefineArg ballast_and_trim.Depth2 = nan m 2021-11-17T17:45:58.843Z,1637171158.843 [MissionManager](INFO): DefineArg ballast_and_trim.DepthDeadband = 0.100000 m 2021-11-17T17:45:58.846Z,1637171158.846 [MissionManager](INFO): DefineArg ballast_and_trim.SurfaceThreshold = 2.500000 m 2021-11-17T17:45:58.850Z,1637171158.850 [MissionManager](INFO): DefineArg ballast_and_trim.MaxWaitOnSurface = 20.000000 min 2021-11-17T17:45:58.853Z,1637171158.853 [MissionManager](INFO): DefineArg ballast_and_trim.SettleTime = 10.000000 min 2021-11-17T17:45:58.856Z,1637171158.856 [MissionManager](INFO): DefineArg ballast_and_trim.EstimationTimeout = 45.000000 min 2021-11-17T17:45:58.860Z,1637171158.860 [MissionManager](INFO): DefineArg ballast_and_trim.MinEstimationTime = 10.000000 min 2021-11-17T17:45:58.863Z,1637171158.863 [MissionManager](INFO): DefineArg ballast_and_trim.MassEstimationErrorBound = 0.250000 mm 2021-11-17T17:45:58.916Z,1637171158.916 [MissionManager](INFO): DefineArg ballast_and_trim.BuoyEstimationErrorBound = 15.000000 cc 2021-11-17T17:45:58.919Z,1637171158.919 [MissionManager](INFO): DefineArg ballast_and_trim.EstimationConfidence = 99.900000 % 2021-11-17T17:45:58.922Z,1637171158.922 [MissionManager](INFO): DefineArg ballast_and_trim.WaitToFloat = 5.000000 min 2021-11-17T17:45:58.923Z,1637171158.923 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml 2021-11-17T17:45:59.386Z,1637171159.386 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PeakDetectChlActive = 0 bool 2021-11-17T17:45:59.389Z,1637171159.389 [MissionManager](INFO): DefineArg ballast_and_trim:Science.TimeWindowPeakReport = nan min 2021-11-17T17:45:59.392Z,1637171159.392 [MissionManager](INFO): DefineArg ballast_and_trim:Science.HighestChlPeakReportActive = 0 bool 2021-11-17T17:45:59.394Z,1637171159.394 [MissionManager](INFO): DefineArg ballast_and_trim:Science.HighestSaltPeakReportActive = 0 bool 2021-11-17T17:45:59.433Z,1637171159.433 [MissionManager](INFO): DefineArg ballast_and_trim:Science.HighestOilPeakReportActive = 0 bool 2021-11-17T17:45:59.436Z,1637171159.436 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PatchTracking = 0 bool 2021-11-17T17:45:59.438Z,1637171159.438 [MissionManager](INFO): DefineArg ballast_and_trim:Science.DetectTrough = 0 bool 2021-11-17T17:45:59.455Z,1637171159.455 [MissionManager](INFO): DefineArg ballast_and_trim:Science.FilterWidthHorizontal = 3.000000 count 2021-11-17T17:45:59.458Z,1637171159.458 [MissionManager](INFO): DefineArg ballast_and_trim:Science.NumProfilesSlidingwindow = 100.000000 count 2021-11-17T17:45:59.496Z,1637171159.496 [MissionManager](INFO): DefineArg ballast_and_trim:Science.OffPeakFractionHorizontal = 80.000000 % 2021-11-17T17:45:59.499Z,1637171159.499 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PeakDetectNO3Active = 0 bool 2021-11-17T17:45:59.501Z,1637171159.501 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PeakDetectOilActive = 0 bool 2021-11-17T17:45:59.512Z,1637171159.512 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PeakDetectFDOMActive = 0 bool 2021-11-17T17:45:59.515Z,1637171159.515 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PeakDetectSalinityActive = 0 bool 2021-11-17T17:45:59.518Z,1637171159.518 [MissionManager](INFO): DefineArg ballast_and_trim:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2021-11-17T17:45:59.521Z,1637171159.521 [MissionManager](INFO): DefineArg ballast_and_trim:Science.EnabledAanderaaO2 = 0.000000 bool 2021-11-17T17:45:59.541Z,1637171159.541 [MissionManager](INFO): DefineArg ballast_and_trim:Science.EnabledNeilBrown = 0.000000 bool 2021-11-17T17:45:59.546Z,1637171159.546 [MissionManager](INFO): DefineArg ballast_and_trim:Science.EnabledSeabird = 1.000000 bool 2021-11-17T17:45:59.558Z,1637171159.558 [MissionManager](INFO): DefineArg ballast_and_trim:Science.EnabledWetLabsBB2FL = 1.000000 bool 2021-11-17T17:45:59.566Z,1637171159.566 [MissionManager](INFO): DefineArg ballast_and_trim:Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool 2021-11-17T17:45:59.574Z,1637171159.574 [MissionManager](INFO): DefineArg ballast_and_trim:Science.EnabledWetLabsUBAT = 0.000000 bool 2021-11-17T17:45:59.579Z,1637171159.579 [MissionManager](INFO): DefineArg ballast_and_trim:Science.LowPassWindowLength = 20.000000 count 2021-11-17T17:45:59.590Z,1637171159.590 [MissionManager](INFO): DefineArg ballast_and_trim:Science.MedianFilterLen = 5.000000 count 2021-11-17T17:45:59.598Z,1637171159.598 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PeakShallowBound = nan m 2021-11-17T17:45:59.601Z,1637171159.601 [MissionManager](INFO): DefineArg ballast_and_trim:Science.PeakDeepBound = nan m 2021-11-17T17:45:59.621Z,1637171159.621 [MissionManager](INFO): DefineArg ballast_and_trim:Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2021-11-17T17:45:59.625Z,1637171159.625 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakChl = 0.000000 ug/l 2021-11-17T17:45:59.636Z,1637171159.636 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakChlDepth = 0.000000 m 2021-11-17T17:45:59.639Z,1637171159.639 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakChlTemperature = 0.000000 degC 2021-11-17T17:45:59.646Z,1637171159.646 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakChlLatitude = nan arcdeg 2021-11-17T17:45:59.664Z,1637171159.664 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakChlLongitude = nan arcdeg 2021-11-17T17:45:59.667Z,1637171159.667 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakNO3 = 0.000000 umol/l 2021-11-17T17:45:59.679Z,1637171159.679 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakNO3Depth = 0.000000 m 2021-11-17T17:45:59.683Z,1637171159.683 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakNO3Latitude = nan arcdeg 2021-11-17T17:45:59.690Z,1637171159.690 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakNO3Longitude = nan arcdeg 2021-11-17T17:45:59.694Z,1637171159.694 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakOil = 0.000000 kg/m3 2021-11-17T17:45:59.710Z,1637171159.710 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakOilDepth = 0.000000 m 2021-11-17T17:45:59.714Z,1637171159.714 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakOilLatitude = nan arcdeg 2021-11-17T17:45:59.725Z,1637171159.725 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakOilLongitude = nan arcdeg 2021-11-17T17:45:59.734Z,1637171159.734 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakFDOM = 0.000000 ppb 2021-11-17T17:45:59.737Z,1637171159.737 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakFDOMDepth = 0.000000 m 2021-11-17T17:45:59.741Z,1637171159.741 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakFDOMTemperature = nan degC 2021-11-17T17:45:59.796Z,1637171159.796 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakFDOMLatitude = nan arcdeg 2021-11-17T17:45:59.799Z,1637171159.799 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakFDOMLongitude = nan arcdeg 2021-11-17T17:45:59.815Z,1637171159.815 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchFDOMDistance = nan m 2021-11-17T17:45:59.834Z,1637171159.834 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakSalt = 0.000000 psu 2021-11-17T17:45:59.842Z,1637171159.842 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakSaltDepth = 0.000000 m 2021-11-17T17:45:59.857Z,1637171159.857 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakSaltTemperature = 0.000000 degC 2021-11-17T17:45:59.860Z,1637171159.861 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakSaltLatitude = nan arcdeg 2021-11-17T17:45:59.872Z,1637171159.872 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PeakSaltLongitude = nan arcdeg 2021-11-17T17:45:59.875Z,1637171159.875 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchChl = 0.000000 ug/l 2021-11-17T17:45:59.892Z,1637171159.892 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchChlDepth = 0.000000 m 2021-11-17T17:45:59.895Z,1637171159.895 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchChlLatitude = nan arcdeg 2021-11-17T17:45:59.905Z,1637171159.905 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchChlLongitude = nan arcdeg 2021-11-17T17:45:59.908Z,1637171159.908 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchChlDistance = nan m 2021-11-17T17:45:59.920Z,1637171159.920 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchSalt = 0.000000 psu 2021-11-17T17:45:59.923Z,1637171159.923 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchSaltDepth = 0.000000 m 2021-11-17T17:45:59.930Z,1637171159.930 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchSaltLatitude = nan arcdeg 2021-11-17T17:45:59.942Z,1637171159.942 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchSaltLongitude = nan arcdeg 2021-11-17T17:45:59.956Z,1637171159.956 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchSaltDistance = nan m 2021-11-17T17:45:59.959Z,1637171159.959 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchOil = 0.000000 psu 2021-11-17T17:45:59.962Z,1637171159.962 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchOilDepth = 0.000000 m 2021-11-17T17:45:59.990Z,1637171159.990 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchOilLatitude = nan arcdeg 2021-11-17T17:45:59.993Z,1637171159.993 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchOilLongitude = nan arcdeg 2021-11-17T17:45:59.998Z,1637171159.998 [MissionManager](INFO): DefineOutput ballast_and_trim:Science.PatchOilDistance = nan m 2021-11-17T17:46:00.058Z,1637171160.058 [ballast_and_trim:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-11-17T17:46:00.095Z,1637171160.095 [ballast_and_trim:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-11-17T17:46:00.129Z,1637171160.129 [ballast_and_trim:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-11-17T17:46:00.154Z,1637171160.154 [ballast_and_trim:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-11-17T17:46:00.228Z,1637171160.228 [ballast_and_trim:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-11-17T17:46:00.273Z,1637171160.273 [ballast_and_trim:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-11-17T17:46:00.305Z,1637171160.305 [ballast_and_trim:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-11-17T17:46:00.334Z,1637171160.334 [ballast_and_trim:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-11-17T17:46:00.354Z,1637171160.354 [MissionManager](INFO): Inserting Stack: Missions/Insert/BallastAndTrim.xml 2021-11-17T17:46:00.555Z,1637171160.555 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertDepth = 25.000000 m 2021-11-17T17:46:00.616Z,1637171160.616 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertApproachSpeed = 0.000000 m/s 2021-11-17T17:46:00.619Z,1637171160.619 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertApproachDepthRate = 0.400000 m/s 2021-11-17T17:46:00.632Z,1637171160.632 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertApproachPitchLimit = 20.000000 arcdeg 2021-11-17T17:46:00.635Z,1637171160.635 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertApproachSettleTimePreDive = 0.000000 min 2021-11-17T17:46:00.638Z,1637171160.638 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertApproachDepthTimeout = 20.000000 min 2021-11-17T17:46:00.663Z,1637171160.663 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertSettleTime = 10.000000 min 2021-11-17T17:46:00.666Z,1637171160.666 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.EstTimeout = 45.000000 min 2021-11-17T17:46:00.669Z,1637171160.669 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.MinEstTime = 10.000000 min 2021-11-17T17:46:00.692Z,1637171160.692 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.MassEstErrorBound = 0.250000 mm 2021-11-17T17:46:00.696Z,1637171160.696 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.BuoyEstErrorBound = 15.000000 cc 2021-11-17T17:46:00.714Z,1637171160.714 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.EstConfidence = 99.900000 % 2021-11-17T17:46:00.723Z,1637171160.723 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertDepthDeadband = 1.000000 m 2021-11-17T17:46:00.726Z,1637171160.726 [MissionManager](INFO): DefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertMassDeadband = 0.250000 mm 2021-11-17T17:46:00.773Z,1637171160.773 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Construct. 2021-11-17T17:46:00.800Z,1637171160.800 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Construct Buoyancy. 2021-11-17T17:46:00.808Z,1637171160.808 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Construct. 2021-11-17T17:46:00.825Z,1637171160.825 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive:B.Wait](DEBUG): Construct Wait. 2021-11-17T17:46:00.834Z,1637171160.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Construct. 2021-11-17T17:46:00.855Z,1637171160.855 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Construct. 2021-11-17T17:46:00.877Z,1637171160.877 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute. 2021-11-17T17:46:00.885Z,1637171160.885 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:A.SetSpeed](DEBUG): Construct. 2021-11-17T17:46:00.892Z,1637171160.892 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:B.Pitch](DEBUG): Construct. 2021-11-17T17:46:00.921Z,1637171160.921 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:D.Wait](DEBUG): Construct Wait. 2021-11-17T17:46:00.946Z,1637171160.946 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:BallastAndTrimAtTargetDepth:F.](DEBUG): Construct BallastAndTrim. 2021-11-17T17:46:01.022Z,1637171161.022 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertDepthDeadband = reader:ballast_and_trim.DepthDeadband 2021-11-17T17:46:01.037Z,1637171161.037 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertApproachDepthTimeout = reader:ballast_and_trim.MaxWaitOnSurface 2021-11-17T17:46:01.039Z,1637171161.039 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.InsertSettleTime = reader:ballast_and_trim.SettleTime 2021-11-17T17:46:01.049Z,1637171161.049 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.EstTimeout = reader:ballast_and_trim.EstimationTimeout 2021-11-17T17:46:01.051Z,1637171161.051 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.MinEstTime = reader:ballast_and_trim.MinEstimationTime 2021-11-17T17:46:01.059Z,1637171161.059 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.MassEstErrorBound = reader:ballast_and_trim.MassEstimationErrorBound 2021-11-17T17:46:01.069Z,1637171161.069 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.BuoyEstErrorBound = reader:ballast_and_trim.BuoyEstimationErrorBound 2021-11-17T17:46:01.071Z,1637171161.071 [MissionManager](INFO): RedefineArg ballast_and_trim:RunBallastAndTrim:BallastAndTrim.EstConfidence = reader:ballast_and_trim.EstimationConfidence 2021-11-17T17:46:01.103Z,1637171161.103 [ballast_and_trim:Float_Up:A.Buoyancy](DEBUG): Construct Buoyancy. 2021-11-17T17:46:01.112Z,1637171161.112 [ballast_and_trim:Float_Up:B.Wait](DEBUG): Construct Wait. 2021-11-17T17:46:01.171Z,1637171161.171 [MissionManager](DEBUG): Maximum duration of mission 120 Skip communications at start of mission. 7 NaN How much vertical drift from the specified depth is allowed durnig the mission. 0.1 Surface threshold depth. 2.5 Maximum wait time for the vehicle to go under the surface (i.e., reach the surface threshold depth). 20 How long to wait after reaching target depth before starting ballast and trim. 10 Timeout for ballast and trim estimation. 45 Minimum time to run ballast and trim estimation before determining convergence (must be shorter than timeout). 10 Desired range of the estimated sample mean from the true mean statistic (smaller values take longer to converge). 0.25 Desired range of the estimated sample mean from the true mean statistic (smaller values take longer to converge). 15 Confidence level that the estimator has reached the desired error range (larger values take longer to converge). 99.9 5 Float to surface instead of driving. 2021-11-17T17:46:01.207Z,1637171161.207 [CommandExec](IMPORTANT): Running ./Missions/Maintenance/tank_ballast_and_trim.xml 2021-11-17T17:46:01.402Z,1637171161.402 [Default] Stopped 2021-11-17T17:46:01.402Z,1637171161.402 [Default](DEBUG): Aggregate::uninitialize Default 2021-11-17T17:46:01.402Z,1637171161.402 [Default:B.GoToSurface] Stopped 2021-11-17T17:46:01.402Z,1637171161.402 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-11-17T17:46:01.402Z,1637171161.402 [Default:CheckIn] Stopped 2021-11-17T17:46:01.402Z,1637171161.402 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-11-17T17:46:01.402Z,1637171161.402 [Default:CheckIn:C.Wait] Stopped 2021-11-17T17:46:01.403Z,1637171161.403 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-11-17T17:46:01.403Z,1637171161.403 [MissionManager](IMPORTANT): Started mission ballast_and_trim 2021-11-17T17:46:01.403Z,1637171161.403 [ballast_and_trim] Running Loop=1 2021-11-17T17:46:01.403Z,1637171161.403 [ballast_and_trim](DEBUG): Aggregate::initialize ballast_and_trim 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science](DEBUG): Aggregate::initialize ballast_and_trim:Science 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:A] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:B] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:C] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:D] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:E] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:F] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:Read_Oil] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:PeakDetectChl] Running Loop=1 2021-11-17T17:46:01.404Z,1637171161.404 [ballast_and_trim:Science:PeakDetectChl](DEBUG): Aggregate::initialize ballast_and_trim:Science:PeakDetectChl 2021-11-17T17:46:01.405Z,1637171161.405 [ballast_and_trim:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2021-11-17T17:46:01.405Z,1637171161.405 [ballast_and_trim:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-11-17T17:46:01.407Z,1637171161.407 [ballast_and_trim:Science:HighestChlPeakReport] Running Loop=1 2021-11-17T17:46:01.416Z,1637171161.416 [ballast_and_trim:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize ballast_and_trim:Science:HighestChlPeakReport 2021-11-17T17:46:01.416Z,1637171161.416 [ballast_and_trim:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-11-17T17:46:01.416Z,1637171161.416 [ballast_and_trim:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-11-17T17:46:01.417Z,1637171161.417 [ballast_and_trim:Science:PeakDetectNO3] Running Loop=1 2021-11-17T17:46:01.417Z,1637171161.417 [ballast_and_trim:Science:PeakDetectNO3](DEBUG): Aggregate::initialize ballast_and_trim:Science:PeakDetectNO3 2021-11-17T17:46:01.417Z,1637171161.417 [ballast_and_trim:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2021-11-17T17:46:01.417Z,1637171161.417 [ballast_and_trim:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-11-17T17:46:01.423Z,1637171161.423 [ballast_and_trim:Science:PeakDetectOil] Running Loop=1 2021-11-17T17:46:01.424Z,1637171161.424 [ballast_and_trim:Science:PeakDetectOil](DEBUG): Aggregate::initialize ballast_and_trim:Science:PeakDetectOil 2021-11-17T17:46:01.424Z,1637171161.424 [ballast_and_trim:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2021-11-17T17:46:01.424Z,1637171161.424 [ballast_and_trim:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-11-17T17:46:01.426Z,1637171161.426 [ballast_and_trim:Science:HighestOilPeakReport] Running Loop=1 2021-11-17T17:46:01.426Z,1637171161.426 [ballast_and_trim:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize ballast_and_trim:Science:HighestOilPeakReport 2021-11-17T17:46:01.426Z,1637171161.426 [ballast_and_trim:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-11-17T17:46:01.426Z,1637171161.426 [ballast_and_trim:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-11-17T17:46:01.427Z,1637171161.427 [ballast_and_trim:Science:PeakDetectFDOM] Running Loop=1 2021-11-17T17:46:01.427Z,1637171161.427 [ballast_and_trim:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize ballast_and_trim:Science:PeakDetectFDOM 2021-11-17T17:46:01.427Z,1637171161.427 [ballast_and_trim:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2021-11-17T17:46:01.427Z,1637171161.427 [ballast_and_trim:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-11-17T17:46:01.433Z,1637171161.433 [ballast_and_trim:Science:PeakDetectSalinity] Running Loop=1 2021-11-17T17:46:01.434Z,1637171161.434 [ballast_and_trim:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize ballast_and_trim:Science:PeakDetectSalinity 2021-11-17T17:46:01.434Z,1637171161.434 [ballast_and_trim:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2021-11-17T17:46:01.434Z,1637171161.434 [ballast_and_trim:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-11-17T17:46:01.440Z,1637171161.440 [ballast_and_trim:Science:HighestSaltPeakReport] Running Loop=1 2021-11-17T17:46:01.440Z,1637171161.440 [ballast_and_trim:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize ballast_and_trim:Science:HighestSaltPeakReport 2021-11-17T17:46:01.440Z,1637171161.440 [ballast_and_trim:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-11-17T17:46:01.440Z,1637171161.440 [ballast_and_trim:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-11-17T17:46:01.441Z,1637171161.441 [ballast_and_trim:Science:OceanCurrent] Running Loop=1 2021-11-17T17:46:01.441Z,1637171161.441 [ballast_and_trim:Science:OceanCurrent](DEBUG): Aggregate::initialize ballast_and_trim:Science:OceanCurrent 2021-11-17T17:46:01.441Z,1637171161.441 [ballast_and_trim:Science:OceanCurrent:A.] Running Loop=1 2021-11-17T17:46:01.441Z,1637171161.441 [ballast_and_trim:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2021-11-17T17:46:01.441Z,1637171161.441 [ballast_and_trim:RunBallastAndTrim] Running Loop=1 2021-11-17T17:46:01.441Z,1637171161.441 [ballast_and_trim:RunBallastAndTrim](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim 2021-11-17T17:46:01.442Z,1637171161.442 [ballast_and_trim:RunBallastAndTrim:Depth1] Running Loop=1 2021-11-17T17:46:01.442Z,1637171161.442 [ballast_and_trim:RunBallastAndTrim:Depth1](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim:Depth1 2021-11-17T17:46:01.442Z,1637171161.442 [ballast_and_trim:RunBallastAndTrim:Depth1:A] Running Loop=1 2021-11-17T17:46:01.443Z,1637171161.443 [ballast_and_trim:RunBallastAndTrim:Depth1:A] Stopped 2021-11-17T17:46:01.443Z,1637171161.443 [ballast_and_trim:RunBallastAndTrim:Depth1:B] Running Loop=1 2021-11-17T17:46:01.447Z,1637171161.447 [ballast_and_trim:RunBallastAndTrim:Depth1:B](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim:Depth1:B 2021-11-17T17:46:01.447Z,1637171161.447 [ballast_and_trim:Science] Running Loop=1 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:HighestSaltPeakReport] Stopped 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:HighestSaltPeakReport 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:PeakDetectSalinity] Stopped 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:PeakDetectSalinity 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-11-17T17:46:01.449Z,1637171161.449 [ballast_and_trim:Science:PeakDetectFDOM] Stopped 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:PeakDetectFDOM 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:HighestOilPeakReport] Stopped 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:HighestOilPeakReport 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:PeakDetectOil] Stopped 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:PeakDetectOil 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2021-11-17T17:46:01.450Z,1637171161.450 [ballast_and_trim:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-11-17T17:46:01.451Z,1637171161.451 [ballast_and_trim:Science:PeakDetectNO3] Stopped 2021-11-17T17:46:01.451Z,1637171161.451 [ballast_and_trim:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:PeakDetectNO3 2021-11-17T17:46:01.451Z,1637171161.451 [ballast_and_trim:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2021-11-17T17:46:01.451Z,1637171161.451 [ballast_and_trim:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-11-17T17:46:01.451Z,1637171161.451 [ballast_and_trim:Science:HighestChlPeakReport] Stopped 2021-11-17T17:46:01.451Z,1637171161.451 [ballast_and_trim:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:HighestChlPeakReport 2021-11-17T17:46:01.451Z,1637171161.451 [ballast_and_trim:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2021-11-17T17:46:01.455Z,1637171161.455 [ballast_and_trim:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:PeakDetectChl] Stopped 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:PeakDetectChl 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:OceanCurrent:A.] Running Loop=1 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:Read_Oil] Stopped 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:F] Stopped 2021-11-17T17:46:01.456Z,1637171161.456 [ballast_and_trim:Science:E] Running Loop=1 2021-11-17T17:46:01.457Z,1637171161.457 [ballast_and_trim:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2021-11-17T17:46:01.457Z,1637171161.457 [ballast_and_trim:Science:D] Stopped 2021-11-17T17:46:01.457Z,1637171161.457 [ballast_and_trim:Science:C] Running Loop=1 2021-11-17T17:46:01.458Z,1637171161.458 [ballast_and_trim:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2021-11-17T17:46:01.459Z,1637171161.459 [ballast_and_trim:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2021-11-17T17:46:01.459Z,1637171161.459 [ballast_and_trim:Science:B] Running Loop=1 2021-11-17T17:46:01.464Z,1637171161.464 [ballast_and_trim:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2021-11-17T17:46:01.465Z,1637171161.465 [ballast_and_trim:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2021-11-17T17:46:01.465Z,1637171161.465 [ballast_and_trim:Science:A] Stopped 2021-11-17T17:46:01.834Z,1637171161.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim] Running Loop=1 2021-11-17T17:46:01.834Z,1637171161.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim 2021-11-17T17:46:01.834Z,1637171161.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:A] Running Loop=1 2021-11-17T17:46:01.834Z,1637171161.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:B] Running Loop=1 2021-11-17T17:46:01.834Z,1637171161.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:C] Running Loop=1 2021-11-17T17:46:01.834Z,1637171161.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:D] Running Loop=1 2021-11-17T17:46:01.834Z,1637171161.834 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:E] Running Loop=1 2021-11-17T17:46:01.835Z,1637171161.835 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:F] Running Loop=1 2021-11-17T17:46:01.837Z,1637171161.837 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:F](INFO): Going to target depth. Speed set to 0.000000 m/s 2021-11-17T17:46:01.837Z,1637171161.837 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:F] Stopped 2021-11-17T17:46:01.837Z,1637171161.837 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth] Running Loop=1 2021-11-17T17:46:01.837Z,1637171161.837 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth 2021-11-17T17:46:01.837Z,1637171161.837 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2021-11-17T17:46:01.837Z,1637171161.837 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold] Running Loop=1 2021-11-17T17:46:01.838Z,1637171161.838 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold 2021-11-17T17:46:01.838Z,1637171161.838 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Running Loop=1 2021-11-17T17:46:01.838Z,1637171161.838 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point](DEBUG): Initialize. 2021-11-17T17:46:01.838Z,1637171161.838 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Running Loop=1 2021-11-17T17:46:01.838Z,1637171161.838 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-11-17T17:46:01.838Z,1637171161.838 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Running Loop=1 2021-11-17T17:46:01.838Z,1637171161.838 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch](DEBUG): Initialize. 2021-11-17T17:46:01.839Z,1637171161.839 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive] Running Loop=1 2021-11-17T17:46:01.839Z,1637171161.839 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive 2021-11-17T17:46:01.839Z,1637171161.839 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Running Loop=1 2021-11-17T17:46:01.839Z,1637171161.839 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:E] Running Loop=1 2021-11-17T17:46:01.839Z,1637171161.839 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:D] Running Loop=1 2021-11-17T17:46:01.840Z,1637171161.840 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:C] Running Loop=1 2021-11-17T17:46:01.840Z,1637171161.840 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:B] Running Loop=1 2021-11-17T17:46:01.840Z,1637171161.840 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:A] Running Loop=1 2021-11-17T17:46:01.845Z,1637171161.845 [WetLabsBB2FL](INFO): Powering up 2021-11-17T17:46:02.218Z,1637171162.218 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive] Stopped 2021-11-17T17:46:02.218Z,1637171162.218 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive 2021-11-17T17:46:02.218Z,1637171162.218 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:WaitPreDive:A] Stopped 2021-11-17T17:46:02.218Z,1637171162.218 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth] Running Loop=1 2021-11-17T17:46:02.218Z,1637171162.218 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::initialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth 2021-11-17T17:46:02.219Z,1637171162.219 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2021-11-17T17:46:02.219Z,1637171162.219 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Initialize. 2021-11-17T17:46:02.219Z,1637171162.219 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Running Loop=1 2021-11-17T17:46:02.219Z,1637171162.219 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold] Stopped 2021-11-17T17:46:02.223Z,1637171162.223 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold 2021-11-17T17:46:02.224Z,1637171162.224 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:A.Point] Stopped 2021-11-17T17:46:02.224Z,1637171162.224 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy] Stopped 2021-11-17T17:46:02.224Z,1637171162.224 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:B.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-11-17T17:46:02.224Z,1637171162.224 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ActuatorHold:C.Pitch] Stopped 2021-11-17T17:46:02.224Z,1637171162.224 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:A] Running Loop=1 2021-11-17T17:46:02.622Z,1637171162.622 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Running Loop=1 2021-11-17T17:46:02.623Z,1637171162.623 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:A](INFO): Moving to 7.000000 m 2021-11-17T17:46:02.623Z,1637171162.623 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:A] Stopped 2021-11-17T17:46:02.623Z,1637171162.623 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Running Loop=1 2021-11-17T17:46:02.623Z,1637171162.623 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch](DEBUG): Initialize. 2021-11-17T17:46:04.777Z,1637171164.777 [CTD_Seabird](ERROR): Failed to parse device response: 2021-11-17T17:46:06.786Z,1637171166.786 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062232 psu 2021-11-17T17:46:07.790Z,1637171167.790 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062232 psu 2021-11-17T17:46:08.794Z,1637171168.794 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062232 psu 2021-11-17T17:46:09.799Z,1637171169.799 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062231 psu 2021-11-17T17:46:10.802Z,1637171170.802 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062124 psu 2021-11-17T17:46:11.806Z,1637171171.806 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062124 psu 2021-11-17T17:46:12.810Z,1637171172.810 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062178 psu 2021-11-17T17:46:13.814Z,1637171173.814 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062124 psu 2021-11-17T17:46:14.818Z,1637171174.818 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062124 psu 2021-11-17T17:46:15.822Z,1637171175.822 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062178 psu 2021-11-17T17:46:16.825Z,1637171176.825 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062231 psu 2021-11-17T17:46:17.830Z,1637171177.830 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062177 psu 2021-11-17T17:46:18.836Z,1637171178.836 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062125 psu 2021-11-17T17:46:19.837Z,1637171179.837 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062178 psu 2021-11-17T17:46:20.846Z,1637171180.846 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062177 psu 2021-11-17T17:46:21.845Z,1637171181.845 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062177 psu 2021-11-17T17:46:22.859Z,1637171182.859 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062177 psu 2021-11-17T17:46:23.861Z,1637171183.861 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062124 psu 2021-11-17T17:46:24.865Z,1637171184.865 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062177 psu 2021-11-17T17:46:25.870Z,1637171185.870 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062177 psu 2021-11-17T17:46:26.874Z,1637171186.874 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062176 psu 2021-11-17T17:46:27.878Z,1637171187.878 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062176 psu 2021-11-17T17:46:28.882Z,1637171188.882 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062176 psu 2021-11-17T17:46:29.886Z,1637171189.886 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062175 psu 2021-11-17T17:46:30.889Z,1637171190.889 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062228 psu 2021-11-17T17:46:31.894Z,1637171191.894 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062228 psu 2021-11-17T17:46:32.898Z,1637171192.898 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062175 psu 2021-11-17T17:46:33.901Z,1637171193.901 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062228 psu 2021-11-17T17:46:34.906Z,1637171194.906 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062282 psu 2021-11-17T17:46:35.909Z,1637171195.909 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062175 psu 2021-11-17T17:46:36.914Z,1637171196.914 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062174 psu 2021-11-17T17:46:37.917Z,1637171197.917 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062227 psu 2021-11-17T17:46:38.921Z,1637171198.921 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062174 psu 2021-11-17T17:46:39.926Z,1637171199.926 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062174 psu 2021-11-17T17:46:40.381Z,1637171200.381 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 2021-11-17T17:46:40.382Z,1637171200.382 [CommandExec](FAULT): Incomplete syntax. Try: help maintain 2021-11-17T17:46:40.929Z,1637171200.929 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062173 psu 2021-11-17T17:46:41.934Z,1637171201.934 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062173 psu 2021-11-17T17:46:42.937Z,1637171202.937 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062226 psu 2021-11-17T17:46:43.941Z,1637171203.941 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062173 psu 2021-11-17T17:46:44.945Z,1637171204.945 [CTD_Seabird](ERROR): Failed to parse device response: -0.11,0.01189,2743.46 2021-11-17T17:46:45.949Z,1637171205.949 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062172 psu 2021-11-17T17:46:46.953Z,1637171206.953 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062171 psu 2021-11-17T17:46:47.958Z,1637171207.958 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062171 psu 2021-11-17T17:46:48.624Z,1637171208.624 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter 2021-11-17T17:46:48.627Z,1637171208.627 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread. 2021-11-17T17:46:48.770Z,1637171208.770 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-11-17T17:46:48.961Z,1637171208.961 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062171 psu 2021-11-17T17:46:49.966Z,1637171209.966 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062171 psu 2021-11-17T17:46:50.969Z,1637171210.969 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062171 psu 2021-11-17T17:46:51.276Z,1637171211.276 [CommandExec](IMPORTANT): got command get depth 2021-11-17T17:46:51.277Z,1637171211.277 [CommandExec](IMPORTANT): depth 3.000000 m 2021-11-17T17:46:51.974Z,1637171211.974 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062225 psu 2021-11-17T17:46:52.977Z,1637171212.977 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062171 psu 2021-11-17T17:46:53.981Z,1637171213.981 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062117 psu 2021-11-17T17:46:54.985Z,1637171214.985 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062116 psu 2021-11-17T17:46:55.990Z,1637171215.990 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062116 psu 2021-11-17T17:46:56.993Z,1637171216.993 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062170 psu 2021-11-17T17:46:57.998Z,1637171217.998 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062116 psu 2021-11-17T17:46:59.002Z,1637171219.002 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062116 psu 2021-11-17T17:47:00.006Z,1637171220.006 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062170 psu 2021-11-17T17:47:01.010Z,1637171221.010 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062223 psu 2021-11-17T17:47:02.014Z,1637171222.014 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062224 psu 2021-11-17T17:47:03.018Z,1637171223.018 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062169 psu 2021-11-17T17:47:04.021Z,1637171224.021 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062169 psu 2021-11-17T17:47:05.025Z,1637171225.025 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062169 psu 2021-11-17T17:47:06.030Z,1637171226.030 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062115 psu 2021-11-17T17:47:07.033Z,1637171227.033 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062115 psu 2021-11-17T17:47:08.037Z,1637171228.037 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062169 psu 2021-11-17T17:47:09.041Z,1637171229.042 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062169 psu 2021-11-17T17:47:10.045Z,1637171230.045 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062170 psu 2021-11-17T17:47:11.049Z,1637171231.049 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062115 psu 2021-11-17T17:47:12.053Z,1637171232.053 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062114 psu 2021-11-17T17:47:13.065Z,1637171233.065 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062168 psu 2021-11-17T17:47:13.389Z,1637171233.389 [CBIT](INFO): Clearing failed state for component DropWeight 2021-11-17T17:47:13.389Z,1637171233.389 [DropWeight] No Fault, FailCount= 1 2021-11-17T17:47:14.065Z,1637171234.065 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062115 psu 2021-11-17T17:47:15.069Z,1637171235.069 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062061 psu 2021-11-17T17:47:16.073Z,1637171236.073 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062115 psu 2021-11-17T17:47:17.077Z,1637171237.077 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062168 psu 2021-11-17T17:47:18.082Z,1637171238.082 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062168 psu 2021-11-17T17:47:19.085Z,1637171239.085 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062168 psu 2021-11-17T17:47:20.091Z,1637171240.091 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062114 psu 2021-11-17T17:47:21.094Z,1637171241.094 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062060 psu 2021-11-17T17:47:22.098Z,1637171242.098 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062005 psu 2021-11-17T17:47:23.102Z,1637171243.102 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062059 psu 2021-11-17T17:47:24.106Z,1637171244.106 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062059 psu 2021-11-17T17:47:25.109Z,1637171245.109 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062059 psu 2021-11-17T17:47:26.114Z,1637171246.114 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062112 psu 2021-11-17T17:47:27.117Z,1637171247.117 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062059 psu 2021-11-17T17:47:28.122Z,1637171248.122 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062113 psu 2021-11-17T17:47:29.147Z,1637171249.147 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062167 psu 2021-11-17T17:47:30.149Z,1637171250.149 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062166 psu 2021-11-17T17:47:30.352Z,1637171250.352 [CommandExec](IMPORTANT): got command failComponent 2021-11-17T17:47:30.352Z,1637171250.352 [CommandExec](IMPORTANT): Failed components: 2021-11-17T17:47:30.352Z,1637171250.352 [CommandExec](IMPORTANT): No failed Components. 2021-11-17T17:47:31.153Z,1637171251.153 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062166 psu 2021-11-17T17:47:32.157Z,1637171252.157 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062166 psu 2021-11-17T17:47:33.162Z,1637171253.162 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062166 psu 2021-11-17T17:47:34.165Z,1637171254.165 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062112 psu 2021-11-17T17:47:35.170Z,1637171255.170 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062166 psu 2021-11-17T17:47:35.497Z,1637171255.497 [CommandExec](IMPORTANT): got command failComponent hardware DropWeight 2021-11-17T17:47:35.497Z,1637171255.497 [DropWeight] Hardware Fault, FailCount= 1 2021-11-17T17:47:35.497Z,1637171255.497 [DropWeight](ERROR): Hardware Fault 2021-11-17T17:47:35.498Z,1637171255.498 [CommandExec](IMPORTANT): DropWeight failureMode is Hardware Fault 2021-11-17T17:47:35.622Z,1637171255.622 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-11-17T17:47:35.622Z,1637171255.622 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-11-17T17:47:35.963Z,1637171255.963 [CBIT](INFO): Critical error at 20211117T174735 2021-11-17T17:47:35.963Z,1637171255.963 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-11-17T17:47:36.173Z,1637171256.173 [CTD_Seabird](ERROR): Salinity reading out of range: 0.062220 psu 2021-11-17T17:47:36.371Z,1637171256.371 [MissionManager](INFO): MissionManager is completed. 2021-11-17T17:47:36.371Z,1637171256.371 [MissionManager](INFO): Uninitializing Mission ballast_and_trim 2021-11-17T17:47:36.371Z,1637171256.371 [ballast_and_trim] Stopped 2021-11-17T17:47:36.371Z,1637171256.371 [ballast_and_trim](DEBUG): Aggregate::uninitialize ballast_and_trim 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science] Stopped 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science](DEBUG): Aggregate::uninitialize ballast_and_trim:Science 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science:B] Stopped 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science:C] Stopped 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science:E] Stopped 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science:OceanCurrent] Stopped 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science:OceanCurrent](DEBUG): Aggregate::uninitialize ballast_and_trim:Science:OceanCurrent 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:Science:OceanCurrent:A.] Stopped 2021-11-17T17:47:36.372Z,1637171256.372 [ballast_and_trim:RunBallastAndTrim] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:A] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:B] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:C] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:D] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:E] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth] Stopped 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth 2021-11-17T17:47:36.373Z,1637171256.373 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:A] Stopped 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth] Stopped 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed] Stopped 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:B.SetSpeed](DEBUG): Uninitialize. 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:BallastAndTrim:GoToTargetDepth:ApproachDepth:C.Pitch] Stopped 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:Depth1] Stopped 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:Depth1](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim:Depth1 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:Depth1:B] Stopped 2021-11-17T17:47:36.374Z,1637171256.374 [ballast_and_trim:RunBallastAndTrim:Depth1:B](DEBUG): Aggregate::uninitialize ballast_and_trim:RunBallastAndTrim:Depth1:B 2021-11-17T17:47:36.761Z,1637171256.761 [MissionManager](IMPORTANT): Started mission Default 2021-11-17T17:47:36.761Z,1637171256.761 [Default] Running Loop=1 2021-11-17T17:47:36.762Z,1637171256.762 [Default](DEBUG): Aggregate::initialize Default 2021-11-17T17:47:36.762Z,1637171256.762 [Default:B.GoToSurface] Running Loop=1 2021-11-17T17:47:36.762Z,1637171256.762 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-11-17T17:47:36.762Z,1637171256.762 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-11-17T17:47:36.762Z,1637171256.762 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-11-17T17:47:36.763Z,1637171256.763 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-11-17T17:47:36.763Z,1637171256.763 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-11-17T17:47:36.764Z,1637171256.764 [WetLabsBB2FL](INFO): Powering down 2021-11-17T17:47:36.780Z,1637171256.780 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-11-17T17:47:36.780Z,1637171256.780 [Default:A.Wait] Running Loop=1 2021-11-17T17:47:36.780Z,1637171256.780 [Default:A.Wait](DEBUG): Initialize Wait Component. 2021-11-17T17:47:37.159Z,1637171257.159 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 20.00 deg, mass-position -35.00 mm (1 active estimators). 2021-11-17T17:47:50.092Z,1637171270.092 [Default:A.Wait](INFO): Done Waiting. 2021-11-17T17:47:50.092Z,1637171270.092 [Default:A.Wait] Stopped 2021-11-17T17:47:50.092Z,1637171270.092 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2021-11-17T17:47:52.530Z,1637171272.530 [CommandExec](IMPORTANT): got command maintain clear 2021-11-17T17:47:52.700Z,1637171272.700 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-11-17T17:47:52.918Z,1637171272.918 [Default:CheckIn] Running Loop=1 2021-11-17T17:47:52.918Z,1637171272.918 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-11-17T17:47:52.918Z,1637171272.918 [Default:CheckIn:Read_GPS] Running Loop=1 2021-11-17T17:47:53.316Z,1637171273.316 [DAT](INFO): DAT read: Lowpower 2021-11-17T17:47:53.317Z,1637171273.317 [DAT](INFO): unknown deviceResponse_: Lowpower 2021-11-17T17:47:54.523Z,1637171274.523 [NAL9602](FAULT): GPS failed to acquire within timeout. 2021-11-17T17:47:54.523Z,1637171274.523 [NAL9602] Data Fault, FailCount= 4 2021-11-17T17:47:54.523Z,1637171274.523 [NAL9602](ERROR): Data Fault 2021-11-17T17:47:54.640Z,1637171274.640 [CBIT](ERROR): Data Fault in component: NAL9602 2021-11-17T17:47:54.936Z,1637171274.936 [NAL9602](INFO): Powering down 2021-11-17T17:47:55.848Z,1637171275.848 [CBIT](INFO): Clearing failed state for component NAL9602 2021-11-17T17:47:55.848Z,1637171275.848 [NAL9602] No Fault, FailCount= 4 2021-11-17T17:48:01.821Z,1637171281.821 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter 2021-11-17T17:48:01.822Z,1637171281.822 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread. 2021-11-17T17:48:01.922Z,1637171281.922 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-11-17T17:48:10.988Z,1637171290.988 [CommandExec](IMPORTANT): got command 2021-11-17T17:48:10.988Z,1637171290.988 [CommandExec](FAULT): Incomplete syntax. Try: help 2021-11-17T17:48:12.028Z,1637171292.028 [CommandExec](IMPORTANT): got command 2021-11-17T17:48:12.028Z,1637171292.028 [CommandExec](FAULT): Incomplete syntax. Try: help 2021-11-17T17:48:13.280Z,1637171293.280 [CommandExec](IMPORTANT): got command failComponent 2021-11-17T17:48:13.280Z,1637171293.280 [CommandExec](IMPORTANT): Failed components: 2021-11-17T17:48:13.281Z,1637171293.281 [CommandExec](IMPORTANT): DropWeight: Hardware Fault 2021-11-17T17:48:18.798Z,1637171298.798 [CommandExec](IMPORTANT): got command failComponent none DropWeight 2021-11-17T17:48:18.799Z,1637171298.799 [DropWeight] No Fault, FailCount= 1 2021-11-17T17:48:18.799Z,1637171298.799 [CommandExec](IMPORTANT): DropWeight failureMode is No Fault 2021-11-17T17:48:19.983Z,1637171299.983 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-11-17T17:48:19.983Z,1637171299.983 [DropWeight] Hardware Fault, FailCount= 2 2021-11-17T17:48:19.983Z,1637171299.983 [DropWeight](ERROR): Hardware Fault 2021-11-17T17:48:20.253Z,1637171300.253 [CBIT](INFO): Critical error at 20211117T174819 2021-11-17T17:48:20.256Z,1637171300.256 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-11-17T17:48:20.256Z,1637171300.256 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-11-17T17:48:20.513Z,1637171300.513 [CBIT](INFO): Critical error at 20211117T174820 2021-11-17T17:48:25.228Z,1637171305.228 [NAL9602](INFO): Powering up NAL9602 2021-11-17T17:48:29.939Z,1637171309.939 [CommandExec](IMPORTANT): got command get depth 2021-11-17T17:48:29.944Z,1637171309.944 [CommandExec](IMPORTANT): depth 3.000000 m 2021-11-17T17:48:36.133Z,1637171316.133 [NAL9602](INFO): NAL9602 initialized 2021-11-17T17:48:46.398Z,1637171326.398 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1637171328.000000 second 2021-11-17T17:48:46.653Z,1637171326.653 [Default:CheckIn:Read_GPS] Stopped 2021-11-17T17:48:46.653Z,1637171326.653 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-11-17T17:48:48.204Z,1637171328.204 [DAT](INFO): #Outgoing data=1 2021-11-17T17:48:48.204Z,1637171328.204 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2021-11-17T17:48:48.473Z,1637171328.473 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2021-11-17T17:48:48.862Z,1637171328.862 [DAT](INFO): DAT read: UART Wakeup 2021-11-17T17:48:48.863Z,1637171328.863 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50m MGP 2021-11-17T17:48:48.864Z,1637171328.864 [DAT](INFO): commRate: 800 2021-11-17T17:48:52.090Z,1637171332.090 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:48:16.4819 2021-11-17T17:48:52.091Z,1637171332.091 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2021-11-17T17:48:56.927Z,1637171336.927 [DataOverHttps](INFO): Sending 255 bytes from file Logs/20211117T174345/Courier0003.lzma 2021-11-17T17:48:57.929Z,1637171337.929 [DataOverHttps](INFO): Moved sent file to Logs/20211117T174345/Courier0003.lzma.bak 2021-11-17T17:48:57.929Z,1637171337.929 [DataOverHttps](INFO): SBD MOMSN=16261820 2021-11-17T17:49:01.009Z,1637171341.009 [DAT](INFO): DAT read: Rx Time:17:48:24.8885 2021-11-17T17:49:01.009Z,1637171341.009 [DAT](INFO): received an acoustic signal 2021-11-17T17:49:02.200Z,1637171342.200 [DAT](INFO): DAT read: 17:48:24.8883 LVL= 32752, 32753, 32754, 32755, AGC= 86, IDX= 371,-0.05, 2.744, 2.824, 2.753, 2.804, PHS=-0.065, 0.064,-0.066, RAW= 330.5, 10.3, CAL= 330.7, 10.7, ROT= 239.3, -10.7 2021-11-17T17:49:02.201Z,1637171342.201 [DAT](INFO): got valid direction response: 17:48:24.8883 LVL= 32752, 32753, 32754, 32755, AGC= 86, IDX= 371,-0.05, 2.744, 2.824, 2.753, 2.804, PHS=-0.065, 0.064,-0.066, RAW= 330.5, 10.3, CAL= 330.7, 10.7, ROT= 239.3, -10.7 2021-11-17T17:49:02.201Z,1637171342.201 [DAT](INFO): DAT read: 2021-11-17T17:49:02.202Z,1637171342.202 [DAT](INFO): DAT read: DATA(0002):~~ 2021-11-17T17:49:02.202Z,1637171342.202 [DAT](INFO): Got DATA 2 2021-11-17T17:49:02.208Z,1637171342.208 [DAT](INFO): DAT read: Source:001 Destination:007 2021-11-17T17:49:02.208Z,1637171342.208 [DAT](INFO): Got Src/Dest after DATA 2021-11-17T17:49:02.208Z,1637171342.208 [DAT](INFO): DATA Src=1, Dst=7 2021-11-17T17:49:02.209Z,1637171342.209 [DAT](INFO): DAT read: CRC:Pass MPD:03.8 PSNR:10.7 AGC:89 SPD:+0.0 CCERR:009 2021-11-17T17:49:02.210Z,1637171342.210 [DAT](INFO): Got CRC:Pass 2021-11-17T17:49:02.210Z,1637171342.210 [DAT](INFO): Got CRC:Pass 2021-11-17T17:49:02.210Z,1637171342.210 [DAT](INFO): Incoming data is intended for us 2021-11-17T17:49:02.210Z,1637171342.210 [DAT](DEBUG): In parseResponses, got ack so set commsState_ = SENDING_VERIFIED 2021-11-17T17:49:02.210Z,1637171342.210 [DAT](INFO): Got ack 2021-11-17T17:49:02.210Z,1637171342.210 [DAT](INFO): DAT read: 2021-11-17T17:49:02.211Z,1637171342.211 [DAT](INFO): DAT read: 2021-11-17T17:49:02.261Z,1637171342.261 [DAT](INFO): Sent 184 bytes from file Logs/20211117T174345/Courier0003.lzma.parts 2021-11-17T17:49:02.262Z,1637171342.262 [DAT](INFO): Packets left to send: 1 2021-11-17T17:49:02.276Z,1637171342.276 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER 2021-11-17T17:49:02.276Z,1637171342.276 [DAT](INFO): #Rx 50: Read direction message, but no range. 2021-11-17T17:49:02.277Z,1637171342.277 [DAT](INFO): direction in vehicle frame: [ -0.501666 forward, -0.844902 starboard, -0.185667 keelward ] 2021-11-17T17:49:02.337Z,1637171342.337 [Default:B.GoToSurface](ERROR): Pitch down timeout. Pitch: -0.53 2021-11-17T17:49:03.593Z,1637171343.593 [DAT](INFO): #Outgoing data=1 2021-11-17T17:49:03.593Z,1637171343.593 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2021-11-17T17:49:03.850Z,1637171343.850 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2021-11-17T17:49:07.547Z,1637171347.547 [DAT](INFO): DAT read: Forwarding Delay UpTx time:17:48:31.8276 2021-11-17T17:49:07.547Z,1637171347.547 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2021-11-17T17:49:15.340Z,1637171355.340 [DataOverHttps](INFO): Sending 5092 bytes from file Logs/20211117T174345/Courier0900.lzma 2021-11-17T17:49:16.333Z,1637171356.333 [DataOverHttps](INFO): Moved sent file to Logs/20211117T174345/Courier0900.lzma.bak 2021-11-17T17:49:16.333Z,1637171356.333 [DataOverHttps](INFO): SBD MOMSN=16261825 2021-11-17T17:49:16.441Z,1637171356.441 [DAT](INFO): DAT read: Rx Time:17:48:40.6241 2021-11-17T17:49:16.441Z,1637171356.441 [DAT](INFO): received an acoustic signal 2021-11-17T17:49:17.256Z,1637171357.256 [DAT](INFO): DAT read: 17:48:40.6241 LVL= 32752, 32753, 32754, 32755, AGC= 88, IDX= 183, 0.44,-2.115,-2.049,-2.106,-2.079, PHS=-0.039, 0.074,-0.041, RAW= 330.9, 1.2, CAL= 331.3, -1.0, ROT= 238.7, 1.0 2021-11-17T17:49:17.258Z,1637171357.258 [DAT](INFO): got valid direction response: 17:48:40.6241 LVL= 32752, 32753, 32754, 32755, AGC= 88, IDX= 183, 0.44,-2.115,-2.049,-2.106,-2.079, PHS=-0.039, 0.074,-0.041, RAW= 330.9, 1.2, CAL= 331.3, -1.0, ROT= 238.7, 1.0 2021-11-17T17:49:17.258Z,1637171357.258 [DAT](INFO): DAT read: 2021-11-17T17:49:17.259Z,1637171357.259 [DAT](INFO): DAT read: DATA(0002):~~ 2021-11-17T17:49:17.259Z,1637171357.259 [DAT](INFO): Got DATA 2 2021-11-17T17:49:17.260Z,1637171357.260 [DAT](INFO): DAT read: Source:001 Destination:007 2021-11-17T17:49:17.260Z,1637171357.260 [DAT](INFO): Got Src/Dest after DATA 2021-11-17T17:49:17.261Z,1637171357.261 [DAT](INFO): DATA Src=1, Dst=7 2021-11-17T17:49:17.261Z,1637171357.261 [DAT](INFO): #Rx 51: Read direction message, but no range. 2021-11-17T17:49:17.263Z,1637171357.263 [DAT](INFO): direction in vehicle frame: [ -0.519440 forward, -0.854329 starboard, 0.017452 keelward ] 2021-11-17T17:49:17.643Z,1637171357.643 [DAT](INFO): DAT read: CRC:Pass MPD:03.8 PSNR:11.0 AGC:89 SPD:+0.0 CCERR:009 2021-11-17T17:49:17.643Z,1637171357.643 [DAT](INFO): Got CRC:Pass 2021-11-17T17:49:17.643Z,1637171357.643 [DAT](INFO): Got CRC:Pass 2021-11-17T17:49:17.643Z,1637171357.643 [DAT](INFO): Incoming data is intended for us 2021-11-17T17:49:17.647Z,1637171357.647 [DAT](DEBUG): In parseResponses, got ack so set commsState_ = SENDING_VERIFIED 2021-11-17T17:49:17.647Z,1637171357.647 [DAT](INFO): Got ack 2021-11-17T17:49:17.648Z,1637171357.648 [DAT](INFO): DAT read: 2021-11-17T17:49:17.648Z,1637171357.648 [DAT](INFO): DAT read: 2021-11-17T17:49:17.649Z,1637171357.649 [DAT](INFO): Sent 184 bytes from file Logs/20211117T174345/Courier0900.lzma.parts 2021-11-17T17:49:17.649Z,1637171357.649 [DAT](INFO): Packets left to send: 27 2021-11-17T17:49:17.651Z,1637171357.651 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER 2021-11-17T17:49:38.189Z,1637171378.189 [DataOverHttps](INFO): Sending 893 bytes from file Logs/20211117T174345/Express0004.lzma 2021-11-17T17:49:39.189Z,1637171379.189 [DataOverHttps](INFO): Moved sent file to Logs/20211117T174345/Express0004.lzma.bak 2021-11-17T17:49:39.189Z,1637171379.189 [DataOverHttps](INFO): SBD MOMSN=16261827 2021-11-17T17:50:00.642Z,1637171400.642 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20211117T174345/Express0007.lzma 2021-11-17T17:50:01.637Z,1637171401.637 [DataOverHttps](INFO): Moved sent file to Logs/20211117T174345/Express0007.lzma.bak 2021-11-17T17:50:01.637Z,1637171401.637 [DataOverHttps](INFO): SBD MOMSN=16261862 2021-11-17T17:50:05.055Z,1637171405.055 [Default:CheckIn:Read_Iridium] Stopped 2021-11-17T17:50:05.055Z,1637171405.055 [Default:CheckIn:C.Wait] Running Loop=1 2021-11-17T17:50:05.055Z,1637171405.055 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-11-17T17:50:59.825Z,1637171459.825 [CBIT](IMPORTANT): Beginning ground fault scan 2021-11-17T17:51:05.447Z,1637171465.447 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-11-17T17:51:05.447Z,1637171465.447 [Default:CheckIn:C.Wait] Stopped 2021-11-17T17:51:05.447Z,1637171465.447 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-11-17T17:51:05.447Z,1637171465.447 [Default:CheckIn:D] Running Loop=1 2021-11-17T17:51:05.853Z,1637171465.853 [Default:CheckIn:D] Stopped 2021-11-17T17:51:05.853Z,1637171465.853 [Default:CheckIn:E] Running Loop=1 2021-11-17T17:51:06.237Z,1637171466.237 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 3.484860 min 2021-11-17T17:51:06.237Z,1637171466.237 [Default:CheckIn:E] Stopped 2021-11-17T17:51:06.237Z,1637171466.237 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-11-17T17:51:06.237Z,1637171466.237 [Default:CheckIn] Stopped 2021-11-17T17:51:06.237Z,1637171466.237 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-11-17T17:51:06.238Z,1637171466.238 [Default:CheckIn](INFO): Running loop #2 2021-11-17T17:51:06.238Z,1637171466.238 [Default:CheckIn] Running Loop=2 2021-11-17T17:51:06.238Z,1637171466.238 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-11-17T17:51:06.238Z,1637171466.238 [Default:CheckIn:Read_GPS] Running Loop=1 2021-11-17T17:51:06.493Z,1637171466.493 [CommandExec](IMPORTANT): got command maintain clear 2021-11-17T17:51:06.740Z,1637171466.740 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,DAT,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2021-11-17T17:51:10.758Z,1637171470.758 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.002584 CHAN A1 (24V): 0.000578 CHAN A2 (12V): -0.002365 CHAN A3 (5V): -0.001700 CHAN B0 (3.3V): -0.000543 CHAN B1 (3.15aV): -0.000969 CHAN B2 (3.15bV): -0.000576 CHAN B3 (GND): 0.000180 OPEN: -0.000609 Full Scale: +/- 1 mA 2021-11-17T17:51:15.745Z,1637171475.745 [CommandExec](IMPORTANT): got command get depth 2021-11-17T17:51:15.746Z,1637171475.746 [CommandExec](IMPORTANT): depth 0.122661 m