2021-04-15T13:42:20.736Z,1618494140.736 [DataOverHttps](INFO): Received command:restart logs 2021-04-15T13:42:20.764Z,1618494140.764 [CommandLine](IMPORTANT): got command restart logs 2021-04-15T13:43:04.136Z,1618494184.136 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-04-15T13:46:25.758Z,1618494385.758 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T13:46:38.283Z,1618494398.283 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-04-15T13:46:38.283Z,1618494398.283 [Default:CheckIn:C.Wait] Stopped 2021-04-15T13:46:38.283Z,1618494398.283 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-04-15T13:46:38.283Z,1618494398.283 [Default:CheckIn:D] Running Loop=1 2021-04-15T13:46:38.679Z,1618494398.679 [Default:CheckIn:D] Stopped 2021-04-15T13:46:38.679Z,1618494398.679 [Default:CheckIn:E] Running Loop=1 2021-04-15T13:46:39.107Z,1618494399.107 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 178.305599 min 2021-04-15T13:46:39.107Z,1618494399.107 [Default:CheckIn:E] Stopped 2021-04-15T13:46:39.107Z,1618494399.107 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-04-15T13:46:39.107Z,1618494399.107 [Default:CheckIn] Stopped 2021-04-15T13:46:39.108Z,1618494399.108 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-04-15T13:46:39.108Z,1618494399.108 [Default:CheckIn](INFO): Running loop #33 2021-04-15T13:46:39.108Z,1618494399.108 [Default:CheckIn] Running Loop=33 2021-04-15T13:46:39.108Z,1618494399.108 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-15T13:46:39.108Z,1618494399.108 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-15T13:46:41.101Z,1618494401.101 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,134640.00,A,4132.79032,N,07041.34143,W,0.467,9.02,150421,,,A*7D 2021-04-15T13:46:41.103Z,1618494401.103 [NAL9602](INFO): GPS fix at 20210415T134640: (41.546505, -70.689024) 2021-04-15T13:46:41.145Z,1618494401.145 [Default:CheckIn:Read_GPS] Stopped 2021-04-15T13:46:41.145Z,1618494401.145 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-15T13:46:44.797Z,1618494404.797 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20210415T104405/Courier0100.lzma 2021-04-15T13:46:45.797Z,1618494405.797 [DataOverHttps](INFO): Moved sent file to Logs/20210415T104405/Courier0100.lzma.bak 2021-04-15T13:46:45.797Z,1618494405.797 [DataOverHttps](INFO): SBD MOMSN=106155 2021-04-15T13:46:54.831Z,1618494414.831 [DataOverHttps](INFO): Sending 255 bytes from file Logs/20210415T134220/Courier0000.lzma 2021-04-15T13:46:55.833Z,1618494415.833 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0000.lzma.bak 2021-04-15T13:46:55.833Z,1618494415.833 [DataOverHttps](INFO): SBD MOMSN=106157 2021-04-15T13:46:56.472Z,1618494416.472 [NAL9602](INFO): SBD MO Status=0, MOMSN=15539, MT Status=0, MTMSN=0 2021-04-15T13:46:56.472Z,1618494416.472 [NAL9602](INFO): No messages in MT queue 2021-04-15T13:47:04.870Z,1618494424.870 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20210415T134220/Courier0003.lzma 2021-04-15T13:47:05.873Z,1618494425.873 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0003.lzma.bak 2021-04-15T13:47:05.873Z,1618494425.873 [DataOverHttps](INFO): SBD MOMSN=106161 2021-04-15T13:47:14.910Z,1618494434.910 [DataOverHttps](INFO): Sending 128 bytes from file Logs/20210415T104405/Express0101.lzma 2021-04-15T13:47:15.914Z,1618494435.914 [DataOverHttps](INFO): Moved sent file to Logs/20210415T104405/Express0101.lzma.bak 2021-04-15T13:47:15.914Z,1618494435.914 [DataOverHttps](INFO): SBD MOMSN=106164 2021-04-15T13:47:24.959Z,1618494444.959 [DataOverHttps](INFO): Sending 325 bytes from file Logs/20210415T134220/Express0001.lzma 2021-04-15T13:47:25.961Z,1618494445.961 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0001.lzma.bak 2021-04-15T13:47:25.961Z,1618494445.961 [DataOverHttps](INFO): SBD MOMSN=106167 2021-04-15T13:47:27.158Z,1618494447.158 [NAL9602](INFO): Not Powering down - fast GPS 2021-04-15T13:47:35.002Z,1618494455.002 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20210415T134220/Express0004.lzma 2021-04-15T13:47:36.005Z,1618494456.005 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0004.lzma.bak 2021-04-15T13:47:36.005Z,1618494456.005 [DataOverHttps](INFO): SBD MOMSN=106171 2021-04-15T13:47:37.295Z,1618494457.295 [Default:CheckIn:Read_Iridium] Stopped 2021-04-15T13:47:37.295Z,1618494457.295 [Default:CheckIn:C.Wait] Running Loop=1 2021-04-15T13:47:37.295Z,1618494457.295 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-04-15T13:48:41.298Z,1618494521.298 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.268528 2021-04-15T13:48:52.335Z,1618494532.335 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003065 2021-04-15T13:52:37.842Z,1618494757.842 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-04-15T13:52:37.842Z,1618494757.842 [Default:CheckIn:C.Wait] Stopped 2021-04-15T13:52:37.842Z,1618494757.842 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-04-15T13:52:37.842Z,1618494757.842 [Default:CheckIn:D] Running Loop=1 2021-04-15T13:52:38.269Z,1618494758.269 [Default:CheckIn:D] Stopped 2021-04-15T13:52:38.270Z,1618494758.270 [Default:CheckIn:E] Running Loop=1 2021-04-15T13:52:38.662Z,1618494758.662 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 184.298763 min 2021-04-15T13:52:38.662Z,1618494758.662 [Default:CheckIn:E] Stopped 2021-04-15T13:52:38.663Z,1618494758.663 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-04-15T13:52:38.663Z,1618494758.663 [Default:CheckIn] Stopped 2021-04-15T13:52:38.663Z,1618494758.663 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-04-15T13:52:38.663Z,1618494758.663 [Default:CheckIn](INFO): Running loop #34 2021-04-15T13:52:38.663Z,1618494758.663 [Default:CheckIn] Running Loop=34 2021-04-15T13:52:38.663Z,1618494758.663 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-15T13:52:38.663Z,1618494758.663 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-15T13:52:40.661Z,1618494760.661 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,135239.00,A,4132.83321,N,07041.40051,W,0.680,339.37,150421,,,D*7B 2021-04-15T13:52:40.663Z,1618494760.663 [NAL9602](INFO): GPS fix at 20210415T135239: (41.547220, -70.690009) 2021-04-15T13:52:40.717Z,1618494760.717 [Default:CheckIn:Read_GPS] Stopped 2021-04-15T13:52:40.717Z,1618494760.717 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-15T13:52:44.266Z,1618494764.266 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210415T134220/Courier0006.lzma 2021-04-15T13:52:45.269Z,1618494765.269 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0006.lzma.bak 2021-04-15T13:52:45.269Z,1618494765.269 [DataOverHttps](INFO): SBD MOMSN=106175 2021-04-15T13:52:54.045Z,1618494774.045 [NAL9602](INFO): SBD MO Status=0, MOMSN=15540, MT Status=0, MTMSN=0 2021-04-15T13:52:54.045Z,1618494774.045 [NAL9602](INFO): No messages in MT queue 2021-04-15T13:52:54.306Z,1618494774.306 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20210415T134220/Express0007.lzma 2021-04-15T13:52:55.309Z,1618494775.309 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0007.lzma.bak 2021-04-15T13:52:55.309Z,1618494775.309 [DataOverHttps](INFO): SBD MOMSN=106178 2021-04-15T13:52:56.458Z,1618494776.458 [Default:CheckIn:Read_Iridium] Stopped 2021-04-15T13:52:56.458Z,1618494776.458 [Default:CheckIn:C.Wait] Running Loop=1 2021-04-15T13:52:56.458Z,1618494776.458 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-04-15T13:53:24.697Z,1618494804.697 [NAL9602](INFO): Not Powering down - fast GPS 2021-04-15T13:53:56.220Z,1618494836.220 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-04-15T13:54:41.073Z,1618494881.073 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-04-15T13:57:57.037Z,1618495077.037 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-04-15T13:57:57.037Z,1618495077.037 [Default:CheckIn:C.Wait] Stopped 2021-04-15T13:57:57.037Z,1618495077.037 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-04-15T13:57:57.037Z,1618495077.037 [Default:CheckIn:D] Running Loop=1 2021-04-15T13:57:57.410Z,1618495077.410 [Default:CheckIn:D] Stopped 2021-04-15T13:57:57.411Z,1618495077.411 [Default:CheckIn:E] Running Loop=1 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 189.617790 min 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn:E] Stopped 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn] Stopped 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn](INFO): Running loop #35 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn] Running Loop=35 2021-04-15T13:57:57.836Z,1618495077.836 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-15T13:57:57.837Z,1618495077.837 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-15T13:57:59.816Z,1618495079.816 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,135759.00,A,4132.86555,N,07041.40830,W,0.311,322.48,150421,,,A*7D 2021-04-15T13:57:59.818Z,1618495079.818 [NAL9602](INFO): GPS fix at 20210415T135759: (41.547759, -70.690138) 2021-04-15T13:57:59.833Z,1618495079.833 [Default:CheckIn:Read_GPS] Stopped 2021-04-15T13:57:59.833Z,1618495079.833 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-15T13:58:03.570Z,1618495083.570 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210415T134220/Courier0009.lzma 2021-04-15T13:58:04.573Z,1618495084.573 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0009.lzma.bak 2021-04-15T13:58:04.573Z,1618495084.573 [DataOverHttps](INFO): SBD MOMSN=106186 2021-04-15T13:58:11.136Z,1618495091.136 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T13:58:13.610Z,1618495093.610 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20210415T134220/Express0010.lzma 2021-04-15T13:58:13.984Z,1618495093.984 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-04-15T13:58:14.613Z,1618495094.613 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0010.lzma.bak 2021-04-15T13:58:14.613Z,1618495094.613 [DataOverHttps](INFO): SBD MOMSN=106189 2021-04-15T13:58:16.026Z,1618495096.026 [Default:CheckIn:Read_Iridium] Stopped 2021-04-15T13:58:16.026Z,1618495096.026 [Default:CheckIn:C.Wait] Running Loop=1 2021-04-15T13:58:16.026Z,1618495096.026 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-04-15T13:58:25.678Z,1618495105.678 [NAL9602](INFO): SBD MO Status=0, MOMSN=15541, MT Status=0, MTMSN=0 2021-04-15T13:58:25.678Z,1618495105.678 [NAL9602](INFO): No messages in MT queue 2021-04-15T13:58:56.385Z,1618495136.385 [NAL9602](INFO): Not Powering down - fast GPS 2021-04-15T14:03:00.789Z,1618495380.789 [DataOverHttps](IMPORTANT): SBD MTMSN=20210415T140259 2021-04-15T14:03:04.803Z,1618495384.803 [DataOverHttps](INFO): Received command:sched asap "load Science/profile_station.xml;set profile_station.MissionTimeout 30 minute;set profile_station.Lat 41.5523 degree;set profile_station.Lon -70.7086 degree;set profile_station.YoYoMinDepth 3 meter" 1occx 1 3 2021-04-15T14:03:04.832Z,1618495384.832 [CommandLine](IMPORTANT): got command schedule asap "load Science/profile_station.xml;set profile_station.MissionTimeout 30 minute;set profile_station.Lat 41.5523 degree;set profile_station.Lon -70.7086 degree;set profile_station.YoYoMinDepth 3 meter" 1occx 1 3.000000 2021-04-15T14:03:04.832Z,1618495384.832 [CommandLine](IMPORTANT): Scheduling command #1 of 3 with id=1occx 2021-04-15T14:03:04.833Z,1618495384.833 [CommandLine](IMPORTANT): Scheduled #1 (#1 of 3 with id='1occx'): "load Science/profile_station.xml;set profile_station.MissionTimeout 30 minute;set profile_station.Lat 41.5523 degree;set profile_station.Lon -70.7086 degree;set profile_station.YoYoMinDepth 3 meter" ASAP 2021-04-15T14:03:05.805Z,1618495385.805 [DataOverHttps](IMPORTANT): SBD MTMSN=20210415T140304 2021-04-15T14:03:09.823Z,1618495389.823 [DataOverHttps](INFO): Received command:sched asap "set profile_station.YoYoMaxDepth 6 meter;set profile_station.YoYoMinAltitude 3 meter;set profile_station.YoYoPitch 15 degree;set profile_station.MinAltitude 3 meter;set profile_station.MaxDepth 8 meter" 1occx 2 3 2021-04-15T14:03:09.880Z,1618495389.880 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.YoYoMaxDepth 6 meter;set profile_station.YoYoMinAltitude 3 meter;set profile_station.YoYoPitch 15 degree;set profile_station.MinAltitude 3 meter;set profile_station.MaxDepth 8 meter" 1occx 2 3.000000 2021-04-15T14:03:09.880Z,1618495389.880 [CommandLine](IMPORTANT): Scheduling command #2 of 3 with id=1occx 2021-04-15T14:03:09.881Z,1618495389.881 [CommandLine](IMPORTANT): Scheduled #2 (#2 of 3 with id='1occx'): "set profile_station.YoYoMaxDepth 6 meter;set profile_station.YoYoMinAltitude 3 meter;set profile_station.YoYoPitch 15 degree;set profile_station.MinAltitude 3 meter;set profile_station.MaxDepth 8 meter" ASAP 2021-04-15T14:03:10.824Z,1618495390.824 [DataOverHttps](IMPORTANT): SBD MTMSN=20210415T140309 2021-04-15T14:03:14.850Z,1618495394.850 [DataOverHttps](INFO): Received command:sched asap "set profile_station.MinOffshore 500 meter;run" 1occx 3 3 2021-04-15T14:03:14.932Z,1618495394.932 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.MinOffshore 500 meter;run" 1occx 3 3.000000 2021-04-15T14:03:14.932Z,1618495394.932 [CommandLine](IMPORTANT): Scheduling command #3 of 3 with id=1occx 2021-04-15T14:03:14.933Z,1618495394.933 [CommandLine](IMPORTANT): Scheduled #3 (#3 of 3 with id='1occx'): "set profile_station.MinOffshore 500 meter;run" ASAP 2021-04-15T14:03:15.066Z,1618495395.066 [CommandLine](IMPORTANT): got command load ./Missions/Science/profile_station.xml 2021-04-15T14:03:15.066Z,1618495395.066 [MissionManager](INFO): Loading Mission: ./Missions/Science/profile_station.xml 2021-04-15T14:03:15.166Z,1618495395.166 [MissionManager](INFO): DefineArg profile_station.MissionTimeout = 4.000000 h 2021-04-15T14:03:15.168Z,1618495395.168 [MissionManager](INFO): DefineArg profile_station.NeedCommsTime = 60.000000 min 2021-04-15T14:03:15.171Z,1618495395.171 [MissionManager](INFO): DefineArg profile_station.Lat = 36.806966 arcdeg 2021-04-15T14:03:15.174Z,1618495395.174 [MissionManager](INFO): DefineArg profile_station.Lon = -121.824326 arcdeg 2021-04-15T14:03:15.177Z,1618495395.177 [MissionManager](INFO): DefineArg profile_station.Radius = 300.000000 m 2021-04-15T14:03:15.180Z,1618495395.180 [MissionManager](INFO): DefineArg profile_station.YoYoMinDepth = 2.000000 m 2021-04-15T14:03:15.183Z,1618495395.183 [MissionManager](INFO): DefineArg profile_station.YoYoMaxDepth = 200.000000 m 2021-04-15T14:03:15.186Z,1618495395.186 [MissionManager](INFO): DefineArg profile_station.YoYoMinAltitude = 7.000000 m 2021-04-15T14:03:15.205Z,1618495395.205 [MissionManager](INFO): DefineArg profile_station.YoYoPitch = 20.000000 arcdeg 2021-04-15T14:03:15.212Z,1618495395.212 [MissionManager](INFO): DefineArg profile_station.Speed = 1.000000 m/s 2021-04-15T14:03:15.214Z,1618495395.214 [MissionManager](INFO): DefineArg profile_station.CircleMaxError = 100.000000 m 2021-04-15T14:03:15.235Z,1618495395.235 [MissionManager](INFO): DefineArg profile_station.CircleTurnToPort = 0 bool 2021-04-15T14:03:15.244Z,1618495395.244 [MissionManager](INFO): DefineArg profile_station.KwpHeading = 0.010000 rad/m 2021-04-15T14:03:15.251Z,1618495395.251 [MissionManager](INFO): DefineArg profile_station.MinAltitude = 5.000000 m 2021-04-15T14:03:15.254Z,1618495395.254 [MissionManager](INFO): DefineArg profile_station.MaxDepth = 205.000000 m 2021-04-15T14:03:15.257Z,1618495395.257 [MissionManager](INFO): DefineArg profile_station.MinOffshore = 2.000000 km 2021-04-15T14:03:15.258Z,1618495395.258 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml 2021-04-15T14:03:15.580Z,1618495395.580 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectChlActive = 0 bool 2021-04-15T14:03:15.583Z,1618495395.583 [MissionManager](INFO): DefineArg profile_station:Science.TimeWindowPeakReport = nan min 2021-04-15T14:03:15.586Z,1618495395.586 [MissionManager](INFO): DefineArg profile_station:Science.HighestChlPeakReportActive = 0 bool 2021-04-15T14:03:15.589Z,1618495395.589 [MissionManager](INFO): DefineArg profile_station:Science.PatchTracking = 0 bool 2021-04-15T14:03:15.600Z,1618495395.600 [MissionManager](INFO): DefineArg profile_station:Science.FilterWidthHorizontal = 3.000000 count 2021-04-15T14:03:15.602Z,1618495395.602 [MissionManager](INFO): DefineArg profile_station:Science.NumProfilesSlidingwindow = 100.000000 count 2021-04-15T14:03:15.609Z,1618495395.609 [MissionManager](INFO): DefineArg profile_station:Science.OffPeakFractionHorizontal = 80.000000 % 2021-04-15T14:03:15.612Z,1618495395.612 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectNO3Active = 0 bool 2021-04-15T14:03:15.623Z,1618495395.623 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectOilActive = 0 bool 2021-04-15T14:03:15.626Z,1618495395.626 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectFDOMActive = 0 bool 2021-04-15T14:03:15.629Z,1618495395.629 [MissionManager](INFO): DefineArg profile_station:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2021-04-15T14:03:15.640Z,1618495395.640 [MissionManager](INFO): DefineArg profile_station:Science.EnabledAanderaaO2 = 0.000000 bool 2021-04-15T14:03:15.646Z,1618495395.646 [MissionManager](INFO): DefineArg profile_station:Science.EnabledNeilBrown = 0.000000 bool 2021-04-15T14:03:15.658Z,1618495395.658 [MissionManager](INFO): DefineArg profile_station:Science.EnabledSeabird = 1.000000 bool 2021-04-15T14:03:15.673Z,1618495395.673 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsBB2FL = 0.000000 bool 2021-04-15T14:03:15.687Z,1618495395.687 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsSeaOWL_UV_A = 1.000000 bool 2021-04-15T14:03:15.695Z,1618495395.695 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsUBAT = 0.000000 bool 2021-04-15T14:03:15.698Z,1618495395.698 [MissionManager](INFO): DefineArg profile_station:Science.LowPassWindowLength = 20.000000 count 2021-04-15T14:03:15.705Z,1618495395.705 [MissionManager](INFO): DefineArg profile_station:Science.MedianFilterLen = 5.000000 count 2021-04-15T14:03:15.710Z,1618495395.710 [MissionManager](INFO): DefineArg profile_station:Science.PeakShallowBound = nan m 2021-04-15T14:03:15.721Z,1618495395.721 [MissionManager](INFO): DefineArg profile_station:Science.PeakDeepBound = nan m 2021-04-15T14:03:15.756Z,1618495395.756 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChl = 0.000000 ug/l 2021-04-15T14:03:15.767Z,1618495395.767 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlDepth = 0.000000 m 2021-04-15T14:03:15.774Z,1618495395.774 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlTemperature = 0.000000 degC 2021-04-15T14:03:15.781Z,1618495395.781 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLatitude = nan arcdeg 2021-04-15T14:03:15.788Z,1618495395.788 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLongitude = nan arcdeg 2021-04-15T14:03:15.807Z,1618495395.807 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3 = 0.000000 umol/l 2021-04-15T14:03:15.812Z,1618495395.812 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Depth = 0.000000 m 2021-04-15T14:03:15.816Z,1618495395.816 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Latitude = nan arcdeg 2021-04-15T14:03:15.818Z,1618495395.818 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Longitude = nan arcdeg 2021-04-15T14:03:15.826Z,1618495395.826 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChl = 0.000000 m 2021-04-15T14:03:15.829Z,1618495395.829 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDepth = 0.000000 m 2021-04-15T14:03:15.849Z,1618495395.849 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLatitude = nan arcdeg 2021-04-15T14:03:15.856Z,1618495395.856 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLongitude = nan arcdeg 2021-04-15T14:03:15.863Z,1618495395.863 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDistance = nan m 2021-04-15T14:03:15.866Z,1618495395.866 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOil = 0.000000 kg/m3 2021-04-15T14:03:15.873Z,1618495395.873 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilDepth = 0.000000 m 2021-04-15T14:03:15.876Z,1618495395.876 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLatitude = nan arcdeg 2021-04-15T14:03:15.891Z,1618495395.891 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLongitude = nan arcdeg 2021-04-15T14:03:15.894Z,1618495395.894 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOM = 0.000000 ppb 2021-04-15T14:03:15.907Z,1618495395.907 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMDepth = 0.000000 m 2021-04-15T14:03:15.917Z,1618495395.917 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMTemperature = nan degC 2021-04-15T14:03:15.932Z,1618495395.932 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLatitude = nan arcdeg 2021-04-15T14:03:15.957Z,1618495395.957 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLongitude = nan arcdeg 2021-04-15T14:03:15.965Z,1618495395.965 [MissionManager](INFO): DefineOutput profile_station:Science.PatchFDOMDistance = nan m 2021-04-15T14:03:16.037Z,1618495396.037 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-04-15T14:03:16.084Z,1618495396.084 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-04-15T14:03:16.107Z,1618495396.107 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-04-15T14:03:16.177Z,1618495396.177 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-04-15T14:03:16.212Z,1618495396.212 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-04-15T14:03:16.232Z,1618495396.232 [MissionManager](INFO): RedefineArg profile_station:Science.PeakDetectChlActive = value:1 bool 2021-04-15T14:03:16.232Z,1618495396.232 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-04-15T14:03:16.362Z,1618495396.362 [MissionManager](INFO): DefineArg profile_station:NeedComms.DiveInterval = 3.000000 h 2021-04-15T14:03:16.365Z,1618495396.365 [MissionManager](INFO): DefineArg profile_station:NeedComms.WaitForPitchUp = 10.000000 min 2021-04-15T14:03:16.369Z,1618495396.369 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-04-15T14:03:16.380Z,1618495396.380 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceDepthRate = nan m/s 2021-04-15T14:03:16.383Z,1618495396.383 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-04-15T14:03:16.390Z,1618495396.390 [MissionManager](INFO): DefineArg profile_station:NeedComms.GPSTimeout = 7.000000 min 2021-04-15T14:03:16.393Z,1618495396.393 [MissionManager](INFO): DefineArg profile_station:NeedComms.CommsTimeout = 30.000000 min 2021-04-15T14:03:16.418Z,1618495396.418 [profile_station:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-04-15T14:03:16.460Z,1618495396.460 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-04-15T14:03:16.492Z,1618495396.492 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinAltitude = 5.000000 m 2021-04-15T14:03:16.495Z,1618495396.495 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MaxDepth = 200.000000 m 2021-04-15T14:03:16.502Z,1618495396.502 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-04-15T14:03:16.507Z,1618495396.507 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-04-15T14:03:16.531Z,1618495396.531 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-04-15T14:03:16.584Z,1618495396.584 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-04-15T14:03:16.621Z,1618495396.621 [profile_station:I.Pitch](DEBUG): Construct. 2021-04-15T14:03:16.643Z,1618495396.643 [profile_station:J.Buoyancy](DEBUG): Construct Buoyancy. 2021-04-15T14:03:16.651Z,1618495396.651 [profile_station:K.SetSpeed](DEBUG): Construct. 2021-04-15T14:03:16.654Z,1618495396.654 [profile_station:L.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-04-15T14:03:16.676Z,1618495396.676 [profile_station:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-04-15T14:03:16.691Z,1618495396.691 [profile_station:N.YoYo](DEBUG): Construct YoYo. 2021-04-15T14:03:16.710Z,1618495396.710 [profile_station:CircleWrapper:B.Circle](DEBUG): Construct. 2021-04-15T14:03:16.769Z,1618495396.769 [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-04-15T14:03:16.769Z,1618495396.769 [CommandLine](IMPORTANT): Loaded ./Missions/Science/profile_station.xml 2021-04-15T14:03:16.990Z,1618495396.990 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-04-15T14:03:16.990Z,1618495396.990 [Default:CheckIn:C.Wait] Stopped 2021-04-15T14:03:16.990Z,1618495396.990 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-04-15T14:03:16.990Z,1618495396.990 [Default:CheckIn:D] Running Loop=1 2021-04-15T14:03:17.458Z,1618495397.458 [Default:CheckIn:D] Stopped 2021-04-15T14:03:17.458Z,1618495397.458 [Default:CheckIn:E] Running Loop=1 2021-04-15T14:03:17.813Z,1618495397.813 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 194.951904 min 2021-04-15T14:03:17.814Z,1618495397.814 [Default:CheckIn:E] Stopped 2021-04-15T14:03:17.814Z,1618495397.814 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-04-15T14:03:17.814Z,1618495397.814 [Default:CheckIn] Stopped 2021-04-15T14:03:17.821Z,1618495397.821 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-04-15T14:03:17.822Z,1618495397.822 [Default:CheckIn](INFO): Running loop #36 2021-04-15T14:03:17.822Z,1618495397.822 [Default:CheckIn] Running Loop=36 2021-04-15T14:03:17.822Z,1618495397.822 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-15T14:03:17.835Z,1618495397.835 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-15T14:03:19.827Z,1618495399.827 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,140319.00,A,4132.89748,N,07041.41828,W,0.389,315.51,150421,,,A*7B 2021-04-15T14:03:19.829Z,1618495399.829 [NAL9602](INFO): GPS fix at 20210415T140319: (41.548291, -70.690305) 2021-04-15T14:03:19.954Z,1618495399.954 [Default:CheckIn:Read_GPS] Stopped 2021-04-15T14:03:19.955Z,1618495399.954 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-15T14:03:23.894Z,1618495403.894 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20210415T134220/Courier0012.lzma 2021-04-15T14:03:24.897Z,1618495404.897 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0012.lzma.bak 2021-04-15T14:03:24.897Z,1618495404.897 [DataOverHttps](INFO): SBD MOMSN=106199 2021-04-15T14:03:26.210Z,1618495406.210 [CommandLine](IMPORTANT): got command set profile_station.MissionTimeout 30.000000 minute 2021-04-15T14:03:26.211Z,1618495406.211 [CommandLine](IMPORTANT): got command set profile_station.Lat 41.552299 degree 2021-04-15T14:03:26.212Z,1618495406.212 [CommandLine](IMPORTANT): got command set profile_station.Lon -70.708603 degree 2021-04-15T14:03:26.213Z,1618495406.213 [CommandLine](IMPORTANT): got command set profile_station.YoYoMinDepth 3.000000 meter 2021-04-15T14:03:33.627Z,1618495413.627 [NAL9602](INFO): SBD MO Status=0, MOMSN=15542, MT Status=0, MTMSN=0 2021-04-15T14:03:33.627Z,1618495413.627 [NAL9602](INFO): No messages in MT queue 2021-04-15T14:03:33.951Z,1618495413.951 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20210415T134220/Courier0015.lzma 2021-04-15T14:03:34.945Z,1618495414.945 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0015.lzma.bak 2021-04-15T14:03:34.945Z,1618495414.945 [DataOverHttps](INFO): SBD MOMSN=106202 2021-04-15T14:03:42.076Z,1618495422.076 [CommandLine](IMPORTANT): got command set profile_station.YoYoMaxDepth 6.000000 meter 2021-04-15T14:03:42.077Z,1618495422.077 [CommandLine](IMPORTANT): got command set profile_station.YoYoMinAltitude 3.000000 meter 2021-04-15T14:03:42.078Z,1618495422.078 [CommandLine](IMPORTANT): got command set profile_station.YoYoPitch 15.000000 degree 2021-04-15T14:03:42.078Z,1618495422.078 [CommandLine](IMPORTANT): got command set profile_station.MinAltitude 3.000000 meter 2021-04-15T14:03:42.083Z,1618495422.083 [CommandLine](IMPORTANT): got command set profile_station.MaxDepth 8.000000 meter 2021-04-15T14:03:44.031Z,1618495424.031 [DataOverHttps](INFO): Sending 538 bytes from file Logs/20210415T134220/Express0013.lzma 2021-04-15T14:03:45.037Z,1618495425.037 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0013.lzma.bak 2021-04-15T14:03:45.037Z,1618495425.037 [DataOverHttps](INFO): SBD MOMSN=106204 2021-04-15T14:03:46.213Z,1618495426.213 [CommandLine](IMPORTANT): got command set profile_station.MinOffshore 500.000000 meter 2021-04-15T14:03:46.214Z,1618495426.214 [CommandLine](IMPORTANT): got command run 2021-04-15T14:03:46.217Z,1618495426.217 [CommandLine](IMPORTANT): Running 2021-04-15T14:03:46.259Z,1618495426.259 [Default] Stopped 2021-04-15T14:03:46.259Z,1618495426.259 [Default](DEBUG): Aggregate::uninitialize Default 2021-04-15T14:03:46.260Z,1618495426.260 [Default:B.GoToSurface] Stopped 2021-04-15T14:03:46.260Z,1618495426.260 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-04-15T14:03:46.260Z,1618495426.260 [Default:CheckIn] Stopped 2021-04-15T14:03:46.260Z,1618495426.260 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-04-15T14:03:46.260Z,1618495426.260 [Default:CheckIn:Read_Iridium] Stopped 2021-04-15T14:03:46.260Z,1618495426.260 [MissionManager](IMPORTANT): Started mission profile_station 2021-04-15T14:03:46.260Z,1618495426.260 [profile_station] Running Loop=1 2021-04-15T14:03:46.260Z,1618495426.260 [profile_station](DEBUG): Aggregate::initialize profile_station 2021-04-15T14:03:46.260Z,1618495426.260 [profile_station:Science] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science](DEBUG): Aggregate::initialize profile_station:Science 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:A] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:B] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:C] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:D] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:E] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:F] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:Read_Oil] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:PeakDetectChl] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectChl 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2021-04-15T14:03:46.261Z,1618495426.261 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-04-15T14:03:46.291Z,1618495426.291 [profile_station:Science:HighestChlPeakReport] Running Loop=1 2021-04-15T14:03:46.291Z,1618495426.291 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize profile_station:Science:HighestChlPeakReport 2021-04-15T14:03:46.292Z,1618495426.292 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2021-04-15T14:03:46.292Z,1618495426.292 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2021-04-15T14:03:46.292Z,1618495426.292 [profile_station:Science:PeakDetectNO3] Running Loop=1 2021-04-15T14:03:46.292Z,1618495426.292 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectNO3 2021-04-15T14:03:46.292Z,1618495426.292 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2021-04-15T14:03:46.292Z,1618495426.292 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-04-15T14:03:46.294Z,1618495426.294 [profile_station:Science:PeakDetectOil] Running Loop=1 2021-04-15T14:03:46.295Z,1618495426.295 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectOil 2021-04-15T14:03:46.303Z,1618495426.303 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2021-04-15T14:03:46.303Z,1618495426.303 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-04-15T14:03:46.305Z,1618495426.305 [profile_station:Science:PeakDetectFDOM] Running Loop=1 2021-04-15T14:03:46.305Z,1618495426.305 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectFDOM 2021-04-15T14:03:46.305Z,1618495426.305 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2021-04-15T14:03:46.305Z,1618495426.305 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2021-04-15T14:03:46.306Z,1618495426.306 [profile_station:Science:OceanCurrent] Running Loop=1 2021-04-15T14:03:46.306Z,1618495426.306 [profile_station:Science:OceanCurrent](DEBUG): Aggregate::initialize profile_station:Science:OceanCurrent 2021-04-15T14:03:46.315Z,1618495426.315 [profile_station:Science:OceanCurrent:A.] Running Loop=1 2021-04-15T14:03:46.315Z,1618495426.315 [profile_station:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2021-04-15T14:03:46.315Z,1618495426.315 [profile_station:StandardEnvelopes] Running Loop=1 2021-04-15T14:03:46.315Z,1618495426.315 [profile_station:StandardEnvelopes](DEBUG): Aggregate::initialize profile_station:StandardEnvelopes 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent. 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:I.Pitch] Running Loop=1 2021-04-15T14:03:46.316Z,1618495426.316 [profile_station:I.Pitch](DEBUG): Initialize. 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:J.Buoyancy] Running Loop=1 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:J.Buoyancy](DEBUG): Initialize Buoyancy Component. 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:K.SetSpeed] Running Loop=1 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:K.SetSpeed](DEBUG): Initialize. 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:L.DepthEnvelope] Running Loop=1 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent. 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:M.AltitudeEnvelope] Running Loop=1 2021-04-15T14:03:46.317Z,1618495426.317 [profile_station:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent. 2021-04-15T14:03:46.318Z,1618495426.318 [profile_station:N.YoYo] Running Loop=1 2021-04-15T14:03:46.318Z,1618495426.318 [profile_station:N.YoYo](DEBUG): Initialize YoYoComponent. 2021-04-15T14:03:46.318Z,1618495426.318 [profile_station:C] Running Loop=1 2021-04-15T14:03:46.319Z,1618495426.319 [profile_station:N.YoYo] Running Loop=1 2021-04-15T14:03:46.327Z,1618495426.327 [profile_station:M.AltitudeEnvelope] Running Loop=1 2021-04-15T14:03:46.328Z,1618495426.328 [profile_station:L.DepthEnvelope] Running Loop=1 2021-04-15T14:03:46.329Z,1618495426.329 [profile_station:K.SetSpeed] Running Loop=1 2021-04-15T14:03:46.329Z,1618495426.329 [profile_station:J.Buoyancy] Running Loop=1 2021-04-15T14:03:46.330Z,1618495426.330 [profile_station:I.Pitch] Running Loop=1 2021-04-15T14:03:46.330Z,1618495426.330 [profile_station:StandardEnvelopes] Running Loop=1 2021-04-15T14:03:46.330Z,1618495426.330 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1 2021-04-15T14:03:46.330Z,1618495426.330 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1 2021-04-15T14:03:46.341Z,1618495426.341 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1 2021-04-15T14:03:46.354Z,1618495426.354 [profile_station:C] Stopped 2021-04-15T14:03:46.354Z,1618495426.354 [profile_station:E] Running Loop=1 2021-04-15T14:03:46.354Z,1618495426.354 [profile_station:Science] Running Loop=1 2021-04-15T14:03:46.374Z,1618495426.374 [profile_station:Science:PeakDetectFDOM] Stopped 2021-04-15T14:03:46.374Z,1618495426.374 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectFDOM 2021-04-15T14:03:46.374Z,1618495426.374 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2021-04-15T14:03:46.374Z,1618495426.374 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-04-15T14:03:46.383Z,1618495426.383 [profile_station:Science:PeakDetectOil] Stopped 2021-04-15T14:03:46.383Z,1618495426.383 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectOil 2021-04-15T14:03:46.383Z,1618495426.383 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2021-04-15T14:03:46.383Z,1618495426.383 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-04-15T14:03:46.383Z,1618495426.383 [profile_station:Science:PeakDetectNO3] Stopped 2021-04-15T14:03:46.383Z,1618495426.383 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectNO3 2021-04-15T14:03:46.383Z,1618495426.383 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:HighestChlPeakReport] Stopped 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize profile_station:Science:HighestChlPeakReport 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:PeakDetectChl] Running Loop=1 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:OceanCurrent:A.] Running Loop=1 2021-04-15T14:03:46.384Z,1618495426.384 [profile_station:Science:Read_Oil] Running Loop=1 2021-04-15T14:03:46.385Z,1618495426.385 [profile_station:Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_petroleum_hydrocarbons_in_sea_water 2021-04-15T14:03:46.385Z,1618495426.385 [profile_station:Science:F] Stopped 2021-04-15T14:03:46.385Z,1618495426.385 [profile_station:Science:E] Running Loop=1 2021-04-15T14:03:46.386Z,1618495426.386 [profile_station:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2021-04-15T14:03:46.386Z,1618495426.386 [profile_station:Science:D] Stopped 2021-04-15T14:03:46.386Z,1618495426.386 [profile_station:Science:C] Running Loop=1 2021-04-15T14:03:46.387Z,1618495426.387 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2021-04-15T14:03:46.388Z,1618495426.388 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2021-04-15T14:03:46.388Z,1618495426.388 [profile_station:Science:B] Running Loop=1 2021-04-15T14:03:46.389Z,1618495426.389 [profile_station:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2021-04-15T14:03:46.389Z,1618495426.389 [profile_station:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2021-04-15T14:03:46.389Z,1618495426.389 [profile_station:Science:A] Stopped 2021-04-15T14:03:46.435Z,1618495426.435 [WetLabsSeaOWL_UV_A](INFO): Powering up 2021-04-15T14:03:46.737Z,1618495426.737 [profile_station:E] Stopped 2021-04-15T14:03:46.737Z,1618495426.737 [profile_station:F] Running Loop=1 2021-04-15T14:03:47.155Z,1618495427.155 [profile_station:F] Stopped 2021-04-15T14:03:47.163Z,1618495427.163 [profile_station:G] Running Loop=1 2021-04-15T14:03:47.553Z,1618495427.553 [profile_station:G] Stopped 2021-04-15T14:03:47.553Z,1618495427.553 [profile_station:StartingMission] Running Loop=1 2021-04-15T14:03:47.553Z,1618495427.553 [profile_station:StartingMission](DEBUG): Aggregate::initialize profile_station:StartingMission 2021-04-15T14:03:47.953Z,1618495427.953 [profile_station:NeedComms] Running Loop=1 2021-04-15T14:03:47.954Z,1618495427.954 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms 2021-04-15T14:03:47.954Z,1618495427.954 [profile_station:NeedComms:B.GoToSurface] Running Loop=1 2021-04-15T14:03:47.954Z,1618495427.954 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-04-15T14:03:47.954Z,1618495427.954 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s. 2021-04-15T14:03:47.955Z,1618495427.955 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees. 2021-04-15T14:03:47.979Z,1618495427.979 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s. 2021-04-15T14:03:47.980Z,1618495427.980 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-04-15T14:03:47.980Z,1618495427.980 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-04-15T14:03:47.980Z,1618495427.980 [profile_station:NeedComms:A] Running Loop=1 2021-04-15T14:03:47.981Z,1618495427.981 [profile_station:NeedComms:A](INFO): last time_fix was: 1618495399.000000 second since 1970/01/01T00:00:00Z 2021-04-15T14:03:47.982Z,1618495427.982 [profile_station:NeedComms:A] Stopped 2021-04-15T14:03:48.290Z,1618495428.290 [profile_station:NeedComms:C] Running Loop=1 2021-04-15T14:03:48.705Z,1618495428.705 [profile_station:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-04-15T14:03:50.120Z,1618495430.120 [CTD_Seabird](ERROR): Failed to parse device response: 2021-04-15T14:03:50.315Z,1618495430.315 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,140349.00,A,4132.90071,N,07041.41856,W,0.661,315.51,150421,,,A*71 2021-04-15T14:03:50.317Z,1618495430.317 [NAL9602](INFO): GPS fix at 20210415T140349: (41.548345, -70.690309) 2021-04-15T14:03:50.339Z,1618495430.339 [profile_station:NeedComms:C] Stopped 2021-04-15T14:03:50.339Z,1618495430.339 [profile_station:NeedComms:D] Running Loop=1 2021-04-15T14:03:50.773Z,1618495430.773 [profile_station:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-04-15T14:03:54.094Z,1618495434.094 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20210415T134220/Express0016.lzma 2021-04-15T14:03:55.097Z,1618495435.097 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0016.lzma.bak 2021-04-15T14:03:55.097Z,1618495435.097 [DataOverHttps](INFO): SBD MOMSN=106222 2021-04-15T14:04:04.134Z,1618495444.134 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20210415T134220/Courier0018.lzma 2021-04-15T14:04:05.138Z,1618495445.138 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0018.lzma.bak 2021-04-15T14:04:05.139Z,1618495445.139 [DataOverHttps](INFO): SBD MOMSN=106224 2021-04-15T14:04:14.177Z,1618495454.177 [DataOverHttps](INFO): Sending 469 bytes from file Logs/20210415T134220/Express0019.lzma 2021-04-15T14:04:15.177Z,1618495455.177 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0019.lzma.bak 2021-04-15T14:04:15.177Z,1618495455.177 [DataOverHttps](INFO): SBD MOMSN=106227 2021-04-15T14:04:16.310Z,1618495456.310 [profile_station:NeedComms:D] Stopped 2021-04-15T14:04:16.310Z,1618495456.310 [profile_station:NeedComms:E] Running Loop=1 2021-04-15T14:04:16.700Z,1618495456.700 [profile_station:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-04-15T14:04:18.303Z,1618495458.303 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,140417.00,A,4132.90405,N,07041.41869,W,0.350,315.51,150421,,,A*71 2021-04-15T14:04:18.305Z,1618495458.305 [NAL9602](INFO): GPS fix at 20210415T140417: (41.548401, -70.690312) 2021-04-15T14:04:18.352Z,1618495458.352 [profile_station:NeedComms:E] Stopped 2021-04-15T14:04:18.352Z,1618495458.352 [profile_station:NeedComms](INFO): Completed profile_station:NeedComms 2021-04-15T14:04:18.352Z,1618495458.352 [profile_station:NeedComms] Stopped 2021-04-15T14:04:18.352Z,1618495458.352 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms 2021-04-15T14:04:18.353Z,1618495458.353 [profile_station:NeedComms:B.GoToSurface] Stopped 2021-04-15T14:04:18.353Z,1618495458.353 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-04-15T14:04:18.753Z,1618495458.753 [profile_station:StartingMission](INFO): Completed profile_station:StartingMission 2021-04-15T14:04:18.754Z,1618495458.754 [profile_station:StartingMission] Stopped 2021-04-15T14:04:18.754Z,1618495458.754 [profile_station:StartingMission](DEBUG): Aggregate::uninitialize profile_station:StartingMission 2021-04-15T14:04:18.754Z,1618495458.754 [profile_station:CircleWrapper] Running Loop=1 2021-04-15T14:04:18.754Z,1618495458.754 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper 2021-04-15T14:04:18.754Z,1618495458.754 [profile_station:CircleWrapper:A] Running Loop=1 2021-04-15T14:04:18.754Z,1618495458.754 [profile_station:CircleWrapper:B.Circle] Running Loop=1 2021-04-15T14:04:18.754Z,1618495458.754 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent. 2021-04-15T14:04:19.137Z,1618495459.137 [profile_station:CircleWrapper:A] Running Loop=1 2021-04-15T14:04:21.545Z,1618495461.545 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T14:04:50.621Z,1618495490.621 [NAL9602](INFO): Not Powering down - fast GPS 2021-04-15T14:04:56.709Z,1618495496.709 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-04-15T14:05:01.954Z,1618495501.954 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T14:05:21.361Z,1618495521.361 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch -15.00 deg, mass-position 12.00 mm (1 active estimators). 2021-04-15T14:05:33.862Z,1618495533.862 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 15.00 deg, mass-position 12.00 mm (2 active estimators). 2021-04-15T14:05:55.579Z,1618495555.579 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239384 2021-04-15T14:06:21.627Z,1618495581.627 [Radio_Surface](INFO): Powering down 2021-04-15T14:06:31.724Z,1618495591.724 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-04-15T14:06:32.727Z,1618495592.727 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2021-04-15T14:06:53.036Z,1618495613.036 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T14:07:02.730Z,1618495622.730 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:07:02.735Z,1618495622.735 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415140702.584464,06,290,24,0092,0150,119,02,02,00,03,-1,-01,-01,1,3,2,0,150,-3.5,0.00,00,3.00,-01,7.21,52,14500,4000*44 2021-04-15T14:07:32.638Z,1618495652.638 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:07:32.661Z,1618495652.661 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415140732.622128,06,211,23,0096,0150,89,02,02,00,02,-1,-01,-01,1,3,7,0,150,-26.0,-3.00,00,6.00,-01,21.71,46,14500,4000*5E 2021-04-15T14:08:02.576Z,1618495682.576 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:08:02.941Z,1618495682.941 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415140802.607405,06,217,23,0106,0150,119,02,02,00,04,-1,-01,-01,1,3,7,0,150,-6.5,1.00,00,2.00,-01,1.22,49,14500,4000*48 2021-04-15T14:09:32.629Z,1618495772.629 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:09:32.633Z,1618495772.633 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415140932.567983,06,429,26,0099,0150,89,02,02,00,03,-1,-01,-01,1,3,5,0,150,2.7,0.00,00,3.00,-01,0.83,47,14500,4000*57 2021-04-15T14:10:02.618Z,1618495802.618 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:10:02.622Z,1618495802.622 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415141002.531619,06,878,29,0107,0150,59,02,02,00,04,-1,-01,-01,1,3,4,0,150,3.3,0.00,00,3.00,-01,6.38,43,14500,4000*5E 2021-04-15T14:10:32.817Z,1618495832.817 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:10:32.826Z,1618495832.826 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415141032.564283,06,1156,30,0110,0150,59,02,02,00,04,-1,-01,-01,1,3,8,0,150,3.1,0.00,00,3.00,-01,-3.96,45,14500,4000*44 2021-04-15T14:11:02.714Z,1618495862.714 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:11:02.720Z,1618495862.720 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415141102.560058,06,888,29,0109,0150,59,02,02,00,04,-1,-01,-01,1,3,5,0,150,2.4,0.00,00,3.00,-01,4.95,44,14500,4000*5C 2021-04-15T14:12:02.523Z,1618495922.523 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:12:02.919Z,1618495922.919 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415141202.531980,06,1046,30,0104,0150,29,01,01,00,02,-1,-01,-01,1,3,2,0,150,1.5,0.00,00,3.00,-01,-2.73,40,14500,4000*4A 2021-04-15T14:12:21.962Z,1618495941.962 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-04-15T14:12:32.028Z,1618495952.028 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-04-15T14:12:32.920Z,1618495952.920 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:12:32.924Z,1618495952.924 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415141232.524579,06,825,29,0093,0150,59,02,02,00,04,-1,-01,-01,1,3,1,0,150,6.0,0.00,00,3.00,-01,1.88,43,14500,4000*55 2021-04-15T14:12:42.106Z,1618495962.106 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-04-15T14:12:46.974Z,1618495966.974 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-04-15T14:12:51.850Z,1618495971.850 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-04-15T14:13:01.943Z,1618495981.943 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-04-15T14:14:04.165Z,1618496044.165 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-04-15T14:14:19.867Z,1618496059.867 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2021-04-15T14:14:19.870Z,1618496059.870 [BPC1](INFO): Received data from all battery sticks. 2021-04-15T14:14:21.942Z,1618496061.942 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:14:31.988Z,1618496071.988 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:14:37.234Z,1618496077.234 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:14:42.088Z,1618496082.088 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:14:46.957Z,1618496086.957 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-04-15T14:14:57.045Z,1618496097.045 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T14:15:11.989Z,1618496111.989 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-04-15T14:15:51.170Z,1618496151.170 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:16:22.301Z,1618496182.301 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:16:27.965Z,1618496187.965 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:16:52.196Z,1618496212.196 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T14:17:32.583Z,1618496252.583 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:17:32.587Z,1618496252.587 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415141732.452455,06,857,29,0091,0150,59,02,02,00,04,-1,-01,-01,1,3,8,0,150,1.1,0.00,00,3.00,-01,2.76,45,14500,4000*53 2021-04-15T14:20:35.218Z,1618496435.218 [Micromodem](INFO): Nmea in: $CAMSG,BAD_CRC, Data Header,2*00 2021-04-15T14:20:35.601Z,1618496435.601 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415142032.607685,06,311,24,0094,0150,59,02,02,00,02,2,-01,-01,2,3,2,0,150,2.1,3.00,07,0.00,-01,2.32,45,14500,4000*7E 2021-04-15T14:22:32.777Z,1618496552.777 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:22:32.781Z,1618496552.781 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415142232.558652,06,1219,30,0108,0150,59,02,02,00,03,4,-01,-01,1,3,7,0,150,2.6,0.00,00,3.00,-01,1.31,47,14500,4000*45 2021-04-15T14:23:02.657Z,1618496582.657 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:23:02.661Z,1618496582.661 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415142302.570263,06,1077,30,0111,0150,29,01,01,00,02,-1,-01,-01,1,3,8,0,150,2.1,-4.00,00,7.00,-01,4.06,38,14500,4000*4B 2021-04-15T14:23:32.567Z,1618496612.567 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:23:32.958Z,1618496612.958 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415142332.602968,06,270,24,0093,0150,89,02,02,00,04,-1,-01,-01,1,3,6,0,150,1.0,0.00,00,3.00,-01,4.17,46,14500,4000*50 2021-04-15T14:24:02.858Z,1618496642.858 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:24:02.862Z,1618496642.862 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415142402.646576,06,737,28,0103,0150,29,01,01,00,01,-1,-01,-01,1,3,5,0,150,2.0,0.00,00,3.00,-01,3.94,38,14500,4000*5F 2021-04-15T14:24:27.115Z,1618496667.115 [RDI_Pathfinder](ERROR): only read -1 of 4 data items 2021-04-15T14:24:32.751Z,1618496672.751 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:24:32.755Z,1618496672.755 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415142432.619124,06,599,27,0104,0150,89,02,02,00,03,-1,-01,-01,1,3,4,0,150,6.5,1.00,00,2.00,-01,3.89,45,14500,4000*55 2021-04-15T14:25:02.665Z,1618496702.665 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:25:02.673Z,1618496702.673 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415142502.634907,06,313,24,0089,0150,89,02,02,00,04,-1,-01,-01,1,3,7,0,150,5.8,0.00,00,3.00,-01,3.88,42,14500,4000*5E 2021-04-15T14:26:50.948Z,1618496810.948 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-04-15T14:31:11.965Z,1618497071.965 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-04-15T14:32:18.191Z,1618497138.191 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:32:33.120Z,1618497153.120 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:32:33.130Z,1618497153.130 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415143232.909433,06,194,22,0090,0150,59,01,01,00,03,-1,-01,-01,1,3,8,0,150,7.1,1.00,00,2.00,-01,2.73,36,14500,4000*5B 2021-04-15T14:32:54.162Z,1618497174.162 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items 2021-04-15T14:33:32.941Z,1618497212.941 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:33:32.949Z,1618497212.949 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415143332.878202,06,89,19,0098,0150,89,02,02,00,04,-1,-01,-01,1,3,7,0,150,-0.3,1.00,00,2.00,-01,4.17,42,14500,4000*4E 2021-04-15T14:33:46.665Z,1618497226.665 [profile_station](INFO): Timed out from 2021-04-15T14:03:46.3Z 2021-04-15T14:33:46.666Z,1618497226.666 [MissionManager](INFO): profile_station is completed. 2021-04-15T14:33:46.666Z,1618497226.666 [MissionManager](INFO): Uninitializing Mission profile_station 2021-04-15T14:33:46.666Z,1618497226.666 [profile_station] Stopped 2021-04-15T14:33:46.666Z,1618497226.666 [profile_station](DEBUG): Aggregate::uninitialize profile_station 2021-04-15T14:33:46.666Z,1618497226.666 [profile_station:Science] Stopped 2021-04-15T14:33:46.666Z,1618497226.666 [profile_station:Science](DEBUG): Aggregate::uninitialize profile_station:Science 2021-04-15T14:33:46.666Z,1618497226.666 [profile_station:Science:B] Stopped 2021-04-15T14:33:46.666Z,1618497226.666 [profile_station:Science:C] Stopped 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:E] Stopped 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:Read_Oil] Stopped 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:OceanCurrent] Stopped 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:OceanCurrent](DEBUG): Aggregate::uninitialize profile_station:Science:OceanCurrent 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:OceanCurrent:A.] Stopped 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:PeakDetectChl] Stopped 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectChl 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2021-04-15T14:33:46.667Z,1618497226.667 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes] Stopped 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes](DEBUG): Aggregate::uninitialize profile_station:StandardEnvelopes 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Stopped 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes:B.DepthEnvelope] Stopped 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize. 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Stopped 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent. 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:I.Pitch] Stopped 2021-04-15T14:33:46.668Z,1618497226.668 [profile_station:J.Buoyancy] Stopped 2021-04-15T14:33:46.669Z,1618497226.669 [profile_station:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component. 2021-04-15T14:33:46.669Z,1618497226.669 [profile_station:K.SetSpeed] Stopped 2021-04-15T14:33:46.669Z,1618497226.669 [profile_station:K.SetSpeed](DEBUG): Uninitialize. 2021-04-15T14:33:46.669Z,1618497226.669 [profile_station:L.DepthEnvelope] Stopped 2021-04-15T14:33:46.669Z,1618497226.669 [profile_station:L.DepthEnvelope](DEBUG): Uninitialize. 2021-04-15T14:33:46.669Z,1618497226.669 [profile_station:M.AltitudeEnvelope] Stopped 2021-04-15T14:33:46.669Z,1618497226.669 [profile_station:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent. 2021-04-15T14:33:46.670Z,1618497226.670 [profile_station:N.YoYo] Stopped 2021-04-15T14:33:46.670Z,1618497226.670 [profile_station:N.YoYo](DEBUG): Uninitialize YoYoComponent. 2021-04-15T14:33:46.670Z,1618497226.670 [profile_station:CircleWrapper] Stopped 2021-04-15T14:33:46.670Z,1618497226.670 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper 2021-04-15T14:33:46.670Z,1618497226.670 [profile_station:CircleWrapper:A] Stopped 2021-04-15T14:33:46.670Z,1618497226.670 [profile_station:CircleWrapper:B.Circle] Stopped 2021-04-15T14:33:46.670Z,1618497226.670 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize. 2021-04-15T14:33:47.055Z,1618497227.055 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:33:47.065Z,1618497227.065 [MissionManager](IMPORTANT): Started mission Default 2021-04-15T14:33:47.065Z,1618497227.065 [Default] Running Loop=1 2021-04-15T14:33:47.065Z,1618497227.065 [Default](DEBUG): Aggregate::initialize Default 2021-04-15T14:33:47.065Z,1618497227.065 [Default:B.GoToSurface] Running Loop=1 2021-04-15T14:33:47.065Z,1618497227.065 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-04-15T14:33:47.065Z,1618497227.065 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-04-15T14:33:47.066Z,1618497227.066 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-04-15T14:33:47.066Z,1618497227.066 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-04-15T14:33:47.066Z,1618497227.066 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-04-15T14:33:47.066Z,1618497227.066 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-04-15T14:33:47.067Z,1618497227.067 [Default:A.Wait] Running Loop=1 2021-04-15T14:33:47.067Z,1618497227.067 [Default:A.Wait](DEBUG): Initialize Wait Component. 2021-04-15T14:33:47.071Z,1618497227.071 [WetLabsSeaOWL_UV_A](INFO): Powering down 2021-04-15T14:33:47.457Z,1618497227.457 [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-04-15T14:33:47.671Z,1618497227.671 [Radio_Surface](INFO): Powering up 2021-04-15T14:33:53.491Z,1618497233.491 [DataOverHttps](INFO): Radio surface powered ON. 2021-04-15T14:34:00.391Z,1618497240.391 [Default:A.Wait](INFO): Done Waiting. 2021-04-15T14:34:00.391Z,1618497240.391 [Default:A.Wait] Stopped 2021-04-15T14:34:00.391Z,1618497240.391 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2021-04-15T14:34:03.207Z,1618497243.207 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:34:03.211Z,1618497243.211 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415143402.909032,06,49,16,0096,0150,119,02,02,00,04,-1,-01,-01,1,3,5,0,150,-0.6,1.00,00,2.00,-01,-0.45,46,14500,4000*54 2021-04-15T14:34:03.215Z,1618497243.215 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:34:15.742Z,1618497255.742 [Default:CheckIn] Running Loop=1 2021-04-15T14:34:15.742Z,1618497255.742 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-15T14:34:15.742Z,1618497255.742 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-15T14:34:23.623Z,1618497263.623 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-04-15T14:34:28.282Z,1618497268.282 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:34:31.936Z,1618497271.936 [NAL9602](INFO): SBD MO Status=0, MOMSN=15543, MT Status=0, MTMSN=0 2021-04-15T14:34:31.937Z,1618497271.937 [NAL9602](INFO): No messages in MT queue 2021-04-15T14:34:33.118Z,1618497273.118 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,143432.00,A,4133.03266,N,07042.36937,W,0.467,198.79,150421,,,A*7A 2021-04-15T14:34:33.121Z,1618497273.121 [NAL9602](INFO): GPS fix at 20210415T143432: (41.550544, -70.706156) 2021-04-15T14:34:33.126Z,1618497273.126 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T14:34:33.131Z,1618497273.131 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:34:33.142Z,1618497273.142 [UniversalFixResidualReporter](INFO): Fix residual: 0.2 %DT, over the last 1489.6 m. Residual distance 3.1 m at bearing 64.0 degrees. Fix at (41.5505, -70.7062) with 1339.9 m made good. 2021-04-15T14:34:33.143Z,1618497273.143 [Default:CheckIn:Read_GPS] Stopped 2021-04-15T14:34:33.143Z,1618497273.143 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-15T14:34:39.568Z,1618497279.568 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:34:39.574Z,1618497279.574 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:34:48.190Z,1618497288.190 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2021-04-15T14:34:50.204Z,1618497290.204 [NAL9602](INFO): SBD MO Status=1, MOMSN=15544, MT Status=0, MTMSN=0 2021-04-15T14:34:50.255Z,1618497290.255 [NAL9602](INFO): Sent 184 bytes from file Logs/20210415T134220/Courier0021.lzma 2021-04-15T14:34:50.255Z,1618497290.255 [NAL9602](INFO): Packets left to send: 1 2021-04-15T14:34:55.198Z,1618497295.198 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2021-04-15T14:34:58.765Z,1618497298.765 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-04-15T14:35:03.291Z,1618497303.291 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:35:08.129Z,1618497308.129 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2021-04-15T14:35:12.994Z,1618497312.994 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:35:13.370Z,1618497313.370 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,O43513,COPROC,0.10.0.46*41 expected 3F 2021-04-15T14:35:16.206Z,1618497316.206 [NAL9602](INFO): SBD MO Status=1, MOMSN=15545, MT Status=0, MTMSN=0 2021-04-15T14:35:16.255Z,1618497316.255 [NAL9602](INFO): Sent 84 bytes from file Logs/20210415T134220/Courier0021.lzma 2021-04-15T14:35:16.255Z,1618497316.255 [NAL9602](INFO): Packets left to send: 0 2021-04-15T14:35:19.492Z,1618497319.492 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items 2021-04-15T14:35:33.904Z,1618497333.904 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-04-15T14:35:39.354Z,1618497339.354 [NAL9602](INFO): SBD MO Status=1, MOMSN=15546, MT Status=0, MTMSN=0 2021-04-15T14:35:39.407Z,1618497339.407 [NAL9602](INFO): Sent 184 bytes from file Logs/20210415T134220/Express0022.lzma 2021-04-15T14:35:39.407Z,1618497339.407 [NAL9602](INFO): Packets left to send: 4 2021-04-15T14:35:43.140Z,1618497343.140 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-04-15T14:35:53.219Z,1618497353.219 [NAL9602](INFO): SBD MO Status=2, MOMSN=15547, MT Status=2, MTMSN=0 2021-04-15T14:35:53.219Z,1618497353.219 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-04-15T14:36:03.117Z,1618497363.117 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:36:03.524Z,1618497363.524 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415143602.922646,06,236,23,0094,0150,89,02,02,00,02,-1,-01,-01,1,3,2,0,150,4.3,1.00,00,2.00,-01,4.34,42,14500,4000*5A 2021-04-15T14:36:09.059Z,1618497369.059 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-04-15T14:36:14.114Z,1618497374.114 [NAL9602](INFO): SBD MO Status=2, MOMSN=15547, MT Status=2, MTMSN=0 2021-04-15T14:36:14.114Z,1618497374.114 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-04-15T14:36:33.546Z,1618497393.546 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:36:33.972Z,1618497393.972 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415143632.935863,06,144,21,0092,0150,119,02,02,00,02,-1,-01,-01,1,3,3,0,150,2.5,1.00,00,2.00,-01,6.38,44,14500,4000*65 2021-04-15T14:36:44.199Z,1618497404.199 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-04-15T14:36:44.836Z,1618497404.836 [NAL9602](INFO): SBD MO Status=2, MOMSN=15547, MT Status=2, MTMSN=0 2021-04-15T14:36:44.836Z,1618497404.836 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-04-15T14:37:10.809Z,1618497430.809 [NAL9602](INFO): SBD MO Status=2, MOMSN=15547, MT Status=2, MTMSN=0 2021-04-15T14:37:10.809Z,1618497430.809 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-04-15T14:37:13.319Z,1618497433.319 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003126 2021-04-15T14:37:17.335Z,1618497437.335 [DataOverHttps](INFO): Sending 816 bytes from file Logs/20210415T134220/Express0022.lzma 2021-04-15T14:37:18.337Z,1618497438.337 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0022.lzma.bak 2021-04-15T14:37:18.337Z,1618497438.337 [DataOverHttps](INFO): SBD MOMSN=106250 2021-04-15T14:37:19.789Z,1618497439.789 [Default:CheckIn:Read_Iridium] Stopped 2021-04-15T14:37:19.789Z,1618497439.789 [Default:CheckIn:C.Wait] Running Loop=1 2021-04-15T14:37:19.789Z,1618497439.789 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-04-15T14:37:29.894Z,1618497449.894 [NAL9602](INFO): SBD MO Status=1, MOMSN=15547, MT Status=0, MTMSN=0 2021-04-15T14:37:29.948Z,1618497449.948 [NAL9602](INFO): Sent 184 bytes from file Logs/20210415T134220/Express0022.lzma 2021-04-15T14:37:29.948Z,1618497449.948 [NAL9602](INFO): Packets left to send: 3 2021-04-15T14:37:33.117Z,1618497453.117 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:37:33.121Z,1618497453.121 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415143732.928217,06,224,23,0094,0150,119,02,02,00,04,-1,-01,-01,1,3,8,0,150,3.7,0.00,00,3.00,-01,4.32,44,14500,4000*66 2021-04-15T14:37:55.005Z,1618497475.005 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude 2021-04-15T14:38:00.582Z,1618497480.582 [NAL9602](INFO): Not Powering down - fast GPS 2021-04-15T14:39:03.201Z,1618497543.201 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:39:03.205Z,1618497543.205 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415143902.968517,06,126,14,0099,0150,149,02,02,01,04,-1,-01,-01,1,3,1,0,150,11.3,7.00,00,-4.00,-01,1.85,42,14500,4000*78 2021-04-15T14:41:33.081Z,1618497693.081 [Micromodem](INFO): Nmea in: $CAMSG,Bad Modulation Header,0*31 2021-04-15T14:41:33.086Z,1618497693.086 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415144132.901760,06,91,19,0092,0150,89,00,00,00,03,-1,-01,-01,1,3,7,0,150,2.4,1.00,00,2.00,-01,5.06,38,14500,4000*65 2021-04-15T14:42:20.369Z,1618497740.369 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-04-15T14:42:20.369Z,1618497740.369 [Default:CheckIn:C.Wait] Stopped 2021-04-15T14:42:20.369Z,1618497740.369 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-04-15T14:42:20.369Z,1618497740.369 [Default:CheckIn:D] Running Loop=1 2021-04-15T14:42:20.779Z,1618497740.779 [Default:CheckIn:D] Stopped 2021-04-15T14:42:20.779Z,1618497740.779 [Default:CheckIn:E] Running Loop=1 2021-04-15T14:42:21.208Z,1618497741.208 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.561898 min 2021-04-15T14:42:21.208Z,1618497741.208 [Default:CheckIn:E] Stopped 2021-04-15T14:42:21.208Z,1618497741.208 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-04-15T14:42:21.208Z,1618497741.208 [Default:CheckIn] Stopped 2021-04-15T14:42:21.208Z,1618497741.208 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-04-15T14:42:21.209Z,1618497741.209 [Default:CheckIn](INFO): Running loop #2 2021-04-15T14:42:21.209Z,1618497741.209 [Default:CheckIn] Running Loop=2 2021-04-15T14:42:21.209Z,1618497741.209 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-04-15T14:42:21.209Z,1618497741.209 [Default:CheckIn:Read_GPS] Running Loop=1 2021-04-15T14:42:23.188Z,1618497743.188 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,144222.00,A,4133.04919,N,07042.37583,W,0.194,335.78,150421,,,D*74 2021-04-15T14:42:23.190Z,1618497743.190 [NAL9602](INFO): GPS fix at 20210415T144222: (41.550820, -70.706264) 2021-04-15T14:42:23.252Z,1618497743.252 [Default:CheckIn:Read_GPS] Stopped 2021-04-15T14:42:23.252Z,1618497743.252 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-04-15T14:42:27.606Z,1618497747.606 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20210415T134220/Courier0024.lzma 2021-04-15T14:42:28.609Z,1618497748.609 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Courier0024.lzma.bak 2021-04-15T14:42:28.609Z,1618497748.609 [DataOverHttps](INFO): SBD MOMSN=106254 2021-04-15T14:42:37.647Z,1618497757.647 [DataOverHttps](INFO): Sending 117 bytes from file Logs/20210415T134220/Express0025.lzma 2021-04-15T14:42:38.649Z,1618497758.649 [DataOverHttps](INFO): Moved sent file to Logs/20210415T134220/Express0025.lzma.bak 2021-04-15T14:42:38.649Z,1618497758.649 [DataOverHttps](INFO): SBD MOMSN=106257 2021-04-15T14:42:39.760Z,1618497759.760 [Default:CheckIn:Read_Iridium] Stopped 2021-04-15T14:42:39.760Z,1618497759.760 [Default:CheckIn:C.Wait] Running Loop=1 2021-04-15T14:42:39.760Z,1618497759.760 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-04-15T14:42:47.830Z,1618497767.830 [NAL9602](INFO): SBD MO Status=0, MOMSN=15548, MT Status=0, MTMSN=0 2021-04-15T14:42:47.831Z,1618497767.831 [NAL9602](INFO): No messages in MT queue 2021-04-15T14:43:04.393Z,1618497784.393 [Micromodem](INFO): Nmea in: $CAMSG,BAD_CRC, Data Header,2*00 2021-04-15T14:43:04.397Z,1618497784.397 [Micromodem](INFO): Nmea in: $CACST,6,1,20210415144302.894851,06,142,15,0092,0150,119,02,02,01,04,1,-01,-01,2,3,1,0,150,5.0,0.00,00,3.00,-01,9.41,39,14500,4000*4C 2021-04-15T14:43:18.533Z,1618497798.533 [NAL9602](INFO): Not Powering down - fast GPS 2021-04-15T14:44:57.968Z,1618497897.968 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error 2021-04-15T14:45:43.591Z,1618497943.591 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout 2021-04-15T14:45:43.591Z,1618497943.591 [RDI_Pathfinder] Communications Fault, FailCount= 1 2021-04-15T14:45:43.591Z,1618497943.591 [RDI_Pathfinder](ERROR): Communications Fault 2021-04-15T14:45:43.649Z,1618497943.649 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder 2021-04-15T14:45:44.047Z,1618497944.047 [RDI_Pathfinder](INFO): Powering down 2021-04-15T14:45:44.849Z,1618497944.849 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder 2021-04-15T14:45:44.849Z,1618497944.849 [RDI_Pathfinder] No Fault, FailCount= 1 2021-04-15T14:47:24.832Z,1618498044.832 [DataOverHttps](IMPORTANT): SBD MTMSN=20210415T144723 2021-04-15T14:47:28.850Z,1618498048.850 [DataOverHttps](INFO): Received command:restart logs