2020-12-13T15:49:32.164Z,1607874572.164 [DataOverHttps](INFO): Received command:restart logs
2020-12-13T15:49:32.181Z,1607874572.181 [CommandLine](IMPORTANT): got command restart logs
2020-12-13T15:50:18.181Z,1607874618.181 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-13T15:50:18.181Z,1607874618.181 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2020-12-13T15:50:18.181Z,1607874618.181 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T15:50:18.181Z,1607874618.181 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2020-12-13T15:50:18.540Z,1607874618.540 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2020-12-13T15:50:18.541Z,1607874618.541 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2020-12-13T15:50:18.943Z,1607874618.943 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 7.090509 min 
2020-12-13T15:50:18.943Z,1607874618.943 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2020-12-13T15:50:18.943Z,1607874618.943 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T15:50:18.943Z,1607874618.943 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2020-12-13T15:50:18.943Z,1607874618.943 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T15:50:18.943Z,1607874618.943 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2
2020-12-13T15:50:18.943Z,1607874618.943 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2
2020-12-13T15:50:18.944Z,1607874618.944 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T15:50:18.944Z,1607874618.944 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2020-12-13T15:50:20.963Z,1607874620.963 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155020.00,A,4133.81673,N,07042.01352,W,0.292,305.15,131220,,,A*7D
2020-12-13T15:50:20.965Z,1607874620.965 [NAL9602](INFO): GPS fix at 20201213T155020: (41.563612, -70.700225)
2020-12-13T15:50:20.976Z,1607874620.976 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2020-12-13T15:50:20.976Z,1607874620.976 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2020-12-13T15:50:24.443Z,1607874624.443 [DataOverHttps](INFO): Sending 51 bytes from file Logs/20201213T143042/Courier0018.lzma
2020-12-13T15:50:25.446Z,1607874625.446 [DataOverHttps](INFO): Moved sent file to Logs/20201213T143042/Courier0018.lzma.bak
2020-12-13T15:50:25.446Z,1607874625.446 [DataOverHttps](INFO): SBD MOMSN=64599
2020-12-13T15:50:34.484Z,1607874634.484 [DataOverHttps](INFO): Sending 256 bytes from file Logs/20201213T154932/Courier0000.lzma
2020-12-13T15:50:35.486Z,1607874635.486 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Courier0000.lzma.bak
2020-12-13T15:50:35.486Z,1607874635.486 [DataOverHttps](INFO): SBD MOMSN=64601
2020-12-13T15:50:44.523Z,1607874644.523 [DataOverHttps](INFO): Sending 94 bytes from file Logs/20201213T143042/Express0019.lzma
2020-12-13T15:50:45.526Z,1607874645.526 [DataOverHttps](INFO): Moved sent file to Logs/20201213T143042/Express0019.lzma.bak
2020-12-13T15:50:45.526Z,1607874645.526 [DataOverHttps](INFO): SBD MOMSN=64605
2020-12-13T15:50:46.808Z,1607874646.808 [NAL9602](INFO): SBD MO Status=0, MOMSN=12786, MT Status=0, MTMSN=0
2020-12-13T15:50:46.808Z,1607874646.808 [NAL9602](INFO): No messages in MT queue
2020-12-13T15:50:54.565Z,1607874654.565 [DataOverHttps](INFO): Sending 340 bytes from file Logs/20201213T154932/Express0001.lzma
2020-12-13T15:50:55.566Z,1607874655.566 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0001.lzma.bak
2020-12-13T15:50:55.566Z,1607874655.566 [DataOverHttps](INFO): SBD MOMSN=64608
2020-12-13T15:50:56.928Z,1607874656.928 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2020-12-13T15:50:56.928Z,1607874656.928 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2020-12-13T15:50:56.929Z,1607874656.929 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-13T15:51:17.518Z,1607874677.518 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T15:53:46.304Z,1607874826.304 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T15:55:57.584Z,1607874957.584 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-13T15:55:57.585Z,1607874957.585 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2020-12-13T15:55:57.585Z,1607874957.585 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T15:55:57.585Z,1607874957.585 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2020-12-13T15:55:57.993Z,1607874957.993 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2020-12-13T15:55:57.993Z,1607874957.993 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2020-12-13T15:55:58.415Z,1607874958.415 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 12.748047 min 
2020-12-13T15:55:58.415Z,1607874958.415 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2020-12-13T15:55:58.415Z,1607874958.415 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T15:55:58.415Z,1607874958.415 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2020-12-13T15:55:58.415Z,1607874958.415 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T15:55:58.415Z,1607874958.415 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #3
2020-12-13T15:55:58.415Z,1607874958.415 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=3
2020-12-13T15:55:58.416Z,1607874958.416 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T15:55:58.416Z,1607874958.416 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2020-12-13T15:56:00.398Z,1607874960.398 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155600.00,A,4133.81050,N,07042.00221,W,0.447,14.65,131220,,,A*40
2020-12-13T15:56:00.400Z,1607874960.400 [NAL9602](INFO): GPS fix at 20201213T155600: (41.563508, -70.700037)
2020-12-13T15:56:00.454Z,1607874960.454 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2020-12-13T15:56:00.454Z,1607874960.454 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2020-12-13T15:56:03.879Z,1607874963.879 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20201213T154932/Courier0003.lzma
2020-12-13T15:56:04.882Z,1607874964.882 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Courier0003.lzma.bak
2020-12-13T15:56:04.882Z,1607874964.882 [DataOverHttps](INFO): SBD MOMSN=64613
2020-12-13T15:56:13.919Z,1607874973.919 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20201213T154932/Express0005.lzma
2020-12-13T15:56:14.922Z,1607874974.922 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0005.lzma.bak
2020-12-13T15:56:14.922Z,1607874974.922 [DataOverHttps](INFO): SBD MOMSN=64616
2020-12-13T15:56:16.601Z,1607874976.601 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2020-12-13T15:56:16.601Z,1607874976.601 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2020-12-13T15:56:16.601Z,1607874976.601 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-13T15:56:18.207Z,1607874978.207 [NAL9602](INFO): SBD MO Status=0, MOMSN=12787, MT Status=0, MTMSN=0
2020-12-13T15:56:18.208Z,1607874978.208 [NAL9602](INFO): No messages in MT queue
2020-12-13T15:56:48.902Z,1607875008.902 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T15:56:56.089Z,1607875016.089 [DataOverHttps](IMPORTANT): SBD MTMSN=20201213T155655
2020-12-13T15:57:00.104Z,1607875020.104 [DataOverHttps](INFO): Received command:sched asap "load Science/profile_station.xml;set profile_station.MissionTimeout 3 hour;set profile_station.Lat 41.57302 degree;set profile_station.Lon -70.69302 degree;set profile_station.YoYoMinDepth 5 meter" hwa7 1 2
2020-12-13T15:57:00.185Z,1607875020.185 [CommandLine](IMPORTANT): got command schedule asap "load Science/profile_station.xml;set profile_station.MissionTimeout 3 hour;set profile_station.Lat 41.57302 degree;set profile_station.Lon -70.69302 degree;set profile_station.YoYoMinDepth 5 meter" hwa7 1 2.000000
2020-12-13T15:57:00.185Z,1607875020.185 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=hwa7
2020-12-13T15:57:00.186Z,1607875020.186 [CommandLine](IMPORTANT): Scheduled #31 (#1 of 2 with id='hwa7'): "load Science/profile_station.xml;set profile_station.MissionTimeout 3 hour;set profile_station.Lat 41.57302 degree;set profile_station.Lon -70.69302 degree;set profile_station.YoYoMinDepth 5 meter" ASAP
2020-12-13T15:57:01.106Z,1607875021.106 [DataOverHttps](IMPORTANT): SBD MTMSN=20201213T155700
2020-12-13T15:57:05.140Z,1607875025.140 [DataOverHttps](INFO): Received command:sched asap "set profile_station.YoYoMaxDepth 7 meter;set profile_station.YoYoMinAltitude 3 meter;set profile_station.YoYoPitch 10 degree;set profile_station.MinAltitude 3 meter;set profile_station.MaxDepth 9 meter;run" hwa7 2 2
2020-12-13T15:57:05.189Z,1607875025.189 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.YoYoMaxDepth 7 meter;set profile_station.YoYoMinAltitude 3 meter;set profile_station.YoYoPitch 10 degree;set profile_station.MinAltitude 3 meter;set profile_station.MaxDepth 9 meter;run" hwa7 2 2.000000
2020-12-13T15:57:05.190Z,1607875025.190 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=hwa7
2020-12-13T15:57:05.190Z,1607875025.190 [CommandLine](IMPORTANT): Scheduled #32 (#2 of 2 with id='hwa7'): "set profile_station.YoYoMaxDepth 7 meter;set profile_station.YoYoMinAltitude 3 meter;set profile_station.YoYoPitch 10 degree;set profile_station.MinAltitude 3 meter;set profile_station.MaxDepth 9 meter;run" ASAP
2020-12-13T15:57:05.516Z,1607875025.516 [CommandLine](IMPORTANT): got command load ./Missions/Science/profile_station.xml
2020-12-13T15:57:05.517Z,1607875025.517 [MissionManager](INFO): Loading Mission: ./Missions/Science/profile_station.xml
2020-12-13T15:57:05.635Z,1607875025.635 [MissionManager](INFO): DefineArg profile_station.MissionTimeout = 4.000000 h
2020-12-13T15:57:05.638Z,1607875025.638 [MissionManager](INFO): DefineArg profile_station.NeedCommsTime = 60.000000 min
2020-12-13T15:57:05.641Z,1607875025.641 [MissionManager](INFO): DefineArg profile_station.Lat = 36.806965 deg
2020-12-13T15:57:05.643Z,1607875025.643 [MissionManager](INFO): DefineArg profile_station.Lon = -121.824326 deg
2020-12-13T15:57:05.645Z,1607875025.645 [MissionManager](INFO): DefineArg profile_station.Radius = 300.000000 m
2020-12-13T15:57:05.647Z,1607875025.647 [MissionManager](INFO): DefineArg profile_station.YoYoMinDepth = 2.000000 m
2020-12-13T15:57:05.650Z,1607875025.650 [MissionManager](INFO): DefineArg profile_station.YoYoMaxDepth = 200.000000 m
2020-12-13T15:57:05.652Z,1607875025.652 [MissionManager](INFO): DefineArg profile_station.YoYoMinAltitude = 7.000000 m
2020-12-13T15:57:05.654Z,1607875025.654 [MissionManager](INFO): DefineArg profile_station.YoYoPitch = 20.000000 deg
2020-12-13T15:57:05.656Z,1607875025.656 [MissionManager](INFO): DefineArg profile_station.Speed = 1.000000 m/s
2020-12-13T15:57:05.658Z,1607875025.658 [MissionManager](INFO): DefineArg profile_station.CircleMaxError = 100.000000 m
2020-12-13T15:57:05.660Z,1607875025.660 [MissionManager](INFO): DefineArg profile_station.CircleTurnToPort = 0 bool
2020-12-13T15:57:05.662Z,1607875025.662 [MissionManager](INFO): DefineArg profile_station.KwpHeading = 0.010000 rad/m
2020-12-13T15:57:05.665Z,1607875025.665 [MissionManager](INFO): DefineArg profile_station.MinAltitude = 5.000000 m
2020-12-13T15:57:05.667Z,1607875025.667 [MissionManager](INFO): DefineArg profile_station.MaxDepth = 205.000000 m
2020-12-13T15:57:05.669Z,1607875025.669 [MissionManager](INFO): DefineArg profile_station.MinOffshore = 2.000000 km
2020-12-13T15:57:05.670Z,1607875025.670 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2020-12-13T15:57:05.936Z,1607875025.936 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectChlActive = 0 bool
2020-12-13T15:57:05.938Z,1607875025.938 [MissionManager](INFO): DefineArg profile_station:Science.TimeWindowPeakReport = nan min
2020-12-13T15:57:05.940Z,1607875025.940 [MissionManager](INFO): DefineArg profile_station:Science.HighestChlPeakReportActive = 0 bool
2020-12-13T15:57:05.942Z,1607875025.942 [MissionManager](INFO): DefineArg profile_station:Science.PatchTracking = 0 bool
2020-12-13T15:57:05.960Z,1607875025.960 [MissionManager](INFO): DefineArg profile_station:Science.FilterWidthHorizontal = 3.000000 count
2020-12-13T15:57:05.962Z,1607875025.962 [MissionManager](INFO): DefineArg profile_station:Science.NumProfilesSlidingwindow = 100.000000 count
2020-12-13T15:57:05.973Z,1607875025.973 [MissionManager](INFO): DefineArg profile_station:Science.OffPeakFractionHorizontal = 80.000000 %
2020-12-13T15:57:05.974Z,1607875025.974 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectNO3Active = 0 bool
2020-12-13T15:57:05.980Z,1607875025.980 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectOilActive = 0 bool
2020-12-13T15:57:05.982Z,1607875025.982 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectFDOMActive = 0 bool
2020-12-13T15:57:05.988Z,1607875025.988 [MissionManager](INFO): DefineArg profile_station:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2020-12-13T15:57:05.994Z,1607875025.994 [MissionManager](INFO): DefineArg profile_station:Science.EnabledAanderaaO2 = 0 bool
2020-12-13T15:57:06.035Z,1607875026.035 [MissionManager](INFO): DefineArg profile_station:Science.EnabledNeilBrown = 0 bool
2020-12-13T15:57:06.059Z,1607875026.059 [MissionManager](INFO): DefineArg profile_station:Science.EnabledSeabird = 1 bool
2020-12-13T15:57:06.074Z,1607875026.074 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsBB2FL = 0 bool
2020-12-13T15:57:06.080Z,1607875026.080 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsSeaOWL_UV_A = 1 bool
2020-12-13T15:57:06.091Z,1607875026.091 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsUBAT = 0 bool
2020-12-13T15:57:06.106Z,1607875026.106 [MissionManager](INFO): DefineArg profile_station:Science.LowPassWindowLength = 20.000000 count
2020-12-13T15:57:06.124Z,1607875026.124 [MissionManager](INFO): DefineArg profile_station:Science.MedianFilterLen = 5.000000 count
2020-12-13T15:57:06.126Z,1607875026.126 [MissionManager](INFO): DefineArg profile_station:Science.PeakShallowBound = nan m
2020-12-13T15:57:06.136Z,1607875026.136 [MissionManager](INFO): DefineArg profile_station:Science.PeakDeepBound = nan m
2020-12-13T15:57:06.139Z,1607875026.139 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChl = 0.000000 ug/l
2020-12-13T15:57:06.147Z,1607875026.147 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlDepth = 0.000000 m
2020-12-13T15:57:06.158Z,1607875026.158 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlTemperature = 0.000000 degC
2020-12-13T15:57:06.164Z,1607875026.164 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLatitude = nan deg
2020-12-13T15:57:06.167Z,1607875026.167 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLongitude = nan deg
2020-12-13T15:57:06.169Z,1607875026.169 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3 = 0.000000 umol/l
2020-12-13T15:57:06.171Z,1607875026.171 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Depth = 0.000000 m
2020-12-13T15:57:06.182Z,1607875026.182 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Latitude = nan deg
2020-12-13T15:57:06.188Z,1607875026.188 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Longitude = nan deg
2020-12-13T15:57:06.193Z,1607875026.193 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChl = 0.000000 m
2020-12-13T15:57:06.195Z,1607875026.195 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDepth = 0.000000 m
2020-12-13T15:57:06.198Z,1607875026.198 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLatitude = nan deg
2020-12-13T15:57:06.204Z,1607875026.204 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLongitude = nan deg
2020-12-13T15:57:06.206Z,1607875026.206 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDistance = nan m
2020-12-13T15:57:06.213Z,1607875026.213 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOil = 0.000000 kg/m3
2020-12-13T15:57:06.215Z,1607875026.215 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilDepth = 0.000000 m
2020-12-13T15:57:06.222Z,1607875026.222 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLatitude = nan deg
2020-12-13T15:57:06.224Z,1607875026.224 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLongitude = nan deg
2020-12-13T15:57:06.226Z,1607875026.226 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOM = 0.000000 ppb
2020-12-13T15:57:06.233Z,1607875026.233 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMDepth = 0.000000 m
2020-12-13T15:57:06.235Z,1607875026.235 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLatitude = nan deg
2020-12-13T15:57:06.241Z,1607875026.241 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLongitude = nan deg
2020-12-13T15:57:06.248Z,1607875026.248 [MissionManager](INFO): DefineOutput profile_station:Science.PatchFDOMDistance = nan m
2020-12-13T15:57:06.352Z,1607875026.352 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-12-13T15:57:06.383Z,1607875026.383 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2020-12-13T15:57:06.425Z,1607875026.425 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-12-13T15:57:06.442Z,1607875026.442 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-12-13T15:57:06.468Z,1607875026.468 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-12-13T15:57:06.490Z,1607875026.490 [MissionManager](INFO): RedefineArg profile_station:Science.PeakDetectChlActive = value:1 bool
2020-12-13T15:57:06.490Z,1607875026.490 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml
2020-12-13T15:57:06.567Z,1607875026.567 [MissionManager](INFO): DefineArg profile_station:NeedComms.DiveInterval = 3.000000 h
2020-12-13T15:57:06.574Z,1607875026.574 [MissionManager](INFO): DefineArg profile_station:NeedComms.WaitForPitchUp = 10.000000 min
2020-12-13T15:57:06.580Z,1607875026.580 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfacePitch = 20.000000 deg
2020-12-13T15:57:06.582Z,1607875026.582 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceDepthRate = nan m/s
2020-12-13T15:57:06.588Z,1607875026.588 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceSpeed = 1.000000 m/s
2020-12-13T15:57:06.590Z,1607875026.590 [MissionManager](INFO): DefineArg profile_station:NeedComms.GPSTimeout = 7.000000 min
2020-12-13T15:57:06.596Z,1607875026.596 [MissionManager](INFO): DefineArg profile_station:NeedComms.CommsTimeout = 30.000000 min
2020-12-13T15:57:06.606Z,1607875026.606 [profile_station:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-12-13T15:57:06.631Z,1607875026.631 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml
2020-12-13T15:57:06.698Z,1607875026.698 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinAltitude = 5.000000 m
2020-12-13T15:57:06.708Z,1607875026.708 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MaxDepth = 200.000000 m
2020-12-13T15:57:06.710Z,1607875026.710 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinOffshore = 2000.000000 m
2020-12-13T15:57:06.711Z,1607875026.711 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2020-12-13T15:57:06.745Z,1607875026.745 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2020-12-13T15:57:06.756Z,1607875026.756 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2020-12-13T15:57:06.774Z,1607875026.774 [profile_station:I.Pitch](DEBUG): Construct.
2020-12-13T15:57:06.788Z,1607875026.788 [profile_station:J.Buoyancy](DEBUG): Construct Buoyancy.
2020-12-13T15:57:06.791Z,1607875026.791 [profile_station:K.SetSpeed](DEBUG): Construct.
2020-12-13T15:57:06.798Z,1607875026.798 [profile_station:L.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2020-12-13T15:57:06.821Z,1607875026.821 [profile_station:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2020-12-13T15:57:06.827Z,1607875026.827 [profile_station:N.YoYo](DEBUG): Construct YoYo.
2020-12-13T15:57:06.847Z,1607875026.847 [profile_station:CircleWrapper:B.Circle](DEBUG): Construct.
2020-12-13T15:57:06.883Z,1607875026.883 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Derivation="Tethys/Derivation"
       xmlns:Estimation="Tethys/Estimation"
       xmlns:Guidance="Tethys/Guidance"
       xmlns:Sensor="Tethys/Sensor"
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Derivation http://okeanids.mbari.org/tethys/Xml/Derivation.xsd
                           Tethys/Estimation http://okeanids.mbari.org/tethys/Xml/Estimation.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="profile_station">

    <Description>
        This mission yoyos in a circle around a specified location.
    </Description>

<!-- Mission-wide settings -->

    <DefineArg Name="MissionTimeout"><Description>
        Maximum duration of mission
    </Description><Units:hour/><Value>4</Value></DefineArg>

    <DefineArg Name="NeedCommsTime"><Description>
        Elapsed time after previous surface communications when vehicle will
        begin to ascend for additional surface communications
    </Description><Units:minute/><Value>60</Value></DefineArg>

<!-- You probably need to change these. -->

    <DefineArg Name="Lat"><Description>
        The latitude of the center of the circle.
    </Description><Units:degree/><Value>36.806966</Value></DefineArg>

    <DefineArg Name="Lon"><Description>
        The longitude of the center of the circle.
    </Description><Units:degree/><Value>-121.824326</Value></DefineArg>

    <DefineArg Name="Radius"><Description>
        Radius to circle at
    </Description><Units:meter/><Value>300</Value></DefineArg>

<!-- You probably do not need to change these. -->

    <DefineArg Name="YoYoMinDepth"><Description>
        Minimum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>2</Value></DefineArg>

    <DefineArg Name="YoYoMaxDepth"><Description>
        Maximum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>200</Value></DefineArg>

    <DefineArg Name="YoYoMinAltitude"><Description>
        Minimum altitude while performing the YoYo behavior (for
        bottom-terminated YoYos).
    </Description><Units:meter/><Value>7</Value></DefineArg>

    <DefineArg Name="YoYoPitch"><Description>
        Pitch (plus and minus) for yo-yo behavior.
    </Description><Units:degree/><Value>20</Value></DefineArg>

    <DefineArg Name="Speed"><Description>
        Vehicle speed.
    </Description><Units:meter_per_second/><Value>1</Value></DefineArg>

<!-- You are even less likely to need to change these. -->

    <DefineArg Name="CircleMaxError"><Description>
        If this distance away from the circle, drive straight towards (or away
        from the center). Otherwise, try to reduce distance from the ideal
        circle.
    </Description><Units:meter/><Value>100</Value></DefineArg>

    <DefineArg Name="CircleTurnToPort"><Description>
        If true, vehicle turns to the left around the center point. If false,
        vehicle turns to the right.
    </Description><False/></DefineArg>

    <DefineArg Name="KwpHeading"><Description>
        Used to relax waypoint cross-track error constant that is adjusted for
        docking. (You can override this setting by passing an argument.)
    </Description><Units:radian_per_meter/><Value>0.010</Value></DefineArg>

    <DefineArg Name="MinAltitude"><Description>
        Minimum height above the sea floor for the entire mission.
    </Description><Units:meter/><Value>5</Value></DefineArg>

    <DefineArg Name="MaxDepth"><Description>
        Maximum depth for the entire mission.
    </Description><Units:meter/><Value>205</Value></DefineArg>

    <DefineArg Name="MinOffshore"><Description>
        Minimum offshore distance for the entire mission.
    </Description><Units:kilometer/><Value>2</Value></DefineArg>

<!-- Missions should almost always start with a timeout -->

    <Timeout Duration="MissionTimeout"/>

    <Insert Filename="Insert/Science.xml">
        <Description>
            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.
        </Description>
        <RedefineArg Name="PeakDetectChlActive"><True/></RedefineArg>
    </Insert>

<!-- Most missions should use the NeedComms aggregate. -->

    <Insert Filename="Insert/NeedComms.xml" Id="NeedComms"/>

    <Assign><Sequence/><Arg Name="NeedComms:DiveInterval"/><Arg Name="NeedCommsTime"/></Assign>

<!-- Missions should almost always start with standard safety envelopes; most missions should not expose the parameters of these envelopes. -->

    <Insert Filename="Insert/StandardEnvelopes.xml"/>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinAltitude"/><Arg Name="MinAltitude"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MaxDepth"/><Arg Name="MaxDepth"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinOffshore"/><Arg Name="MinOffshore"/></Assign>

<!-- Check for additional instructions first. -->

    <Call Id="StartingMission" RefId="NeedComms"/>

<!-- Many missions will keep mass position and buoyancy volume fixed at defaults. -->

    <Guidance:Pitch>
        <Parallel/>
        <Setting><Guidance:Pitch.massPosition/><Control:VerticalControl.massDefault/></Setting>
    </Guidance:Pitch>

    <Guidance:Buoyancy>
        <Parallel/>
        <Setting><Guidance:Buoyancy.position/><Control:VerticalControl.buoyancyNeutral/></Setting>
    </Guidance:Buoyancy>

    <Guidance:SetSpeed>
        <Parallel/>
        <Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
    </Guidance:SetSpeed>

    <Guidance:DepthEnvelope>
        <Description>
            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.
        </Description>
        <Parallel/>
        <Setting><Guidance:DepthEnvelope.minDepth/><Arg Name="YoYoMinDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Arg Name="YoYoMaxDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:DepthEnvelope>

    <Guidance:AltitudeEnvelope>
        <Description>
            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.
        </Description>
        <Parallel/>
        <Setting><Guidance:AltitudeEnvelope.minAltitude/><Arg Name="YoYoMinAltitude"/></Setting>
        <Setting><Guidance:AltitudeEnvelope.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:AltitudeEnvelope>

    <Guidance:YoYo>
        <Parallel/>
        <Setting><Guidance:YoYo.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:YoYo>

    <Aggregate Id="CircleWrapper">

        <Sequence Repeat="4096"/>

        <Assign><Parallel/><Control:HorizontalControl.kwpHeading/><Arg Name="KwpHeading"/></Assign>

        <Guidance:Circle>
            <Sequence/>
            <Setting><Guidance:Circle.latitude/><Arg Name="Lat"/></Setting>
            <Setting><Guidance:Circle.longitude/><Arg Name="Lon"/></Setting>
            <Setting><Guidance:Circle.radius/><Arg Name="Radius"/></Setting>
            <Setting><Guidance:Circle.maxError/><Arg Name="CircleMaxError"/></Setting>
            <Setting><Guidance:Circle.turnToPort/><Arg Name="CircleTurnToPort"/></Setting>
        </Guidance:Circle>

    </Aggregate>

</Mission>


2020-12-13T15:57:06.883Z,1607875026.883 [CommandLine](IMPORTANT): Loaded ./Missions/Science/profile_station.xml
2020-12-13T15:57:17.043Z,1607875037.043 [CommandLine](IMPORTANT): got command set profile_station.MissionTimeout 3 hour
2020-12-13T15:57:17.045Z,1607875037.045 [CommandLine](IMPORTANT): got command set profile_station.Lat 41.57302 degree
2020-12-13T15:57:17.047Z,1607875037.047 [CommandLine](IMPORTANT): got command set profile_station.Lon -70.69302 degree
2020-12-13T15:57:17.049Z,1607875037.049 [CommandLine](IMPORTANT): got command set profile_station.YoYoMinDepth 5 meter
2020-12-13T15:57:31.739Z,1607875051.739 [CommandLine](IMPORTANT): got command set profile_station.YoYoMaxDepth 7 meter
2020-12-13T15:57:31.752Z,1607875051.752 [CommandLine](IMPORTANT): got command set profile_station.YoYoMinAltitude 3 meter
2020-12-13T15:57:31.753Z,1607875051.753 [CommandLine](IMPORTANT): got command set profile_station.YoYoPitch 10 degree
2020-12-13T15:57:31.754Z,1607875051.754 [CommandLine](IMPORTANT): got command set profile_station.MinAltitude 3 meter
2020-12-13T15:57:31.754Z,1607875051.754 [CommandLine](IMPORTANT): got command set profile_station.MaxDepth 9 meter
2020-12-13T15:57:31.755Z,1607875051.755 [CommandLine](IMPORTANT): got command run
2020-12-13T15:57:31.802Z,1607875051.802 [CommandLine](IMPORTANT): Running 
2020-12-13T15:57:31.853Z,1607875051.853 [DefaultWithUndock] Stopped
2020-12-13T15:57:31.853Z,1607875051.853 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-12-13T15:57:31.853Z,1607875051.853 [DefaultWithUndock:SurfaceDefault] Stopped
2020-12-13T15:57:31.854Z,1607875051.854 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault
2020-12-13T15:57:31.854Z,1607875051.854 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped
2020-12-13T15:57:31.854Z,1607875051.854 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-13T15:57:31.854Z,1607875051.854 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2020-12-13T15:57:31.854Z,1607875051.854 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T15:57:31.854Z,1607875051.854 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2020-12-13T15:57:31.854Z,1607875051.854 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T15:57:31.854Z,1607875051.854 [MissionManager](IMPORTANT): Started mission profile_station
2020-12-13T15:57:31.854Z,1607875051.854 [profile_station] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station](DEBUG): Aggregate::initialize profile_station
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science](DEBUG): Aggregate::initialize profile_station:Science
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:A] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:B] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:C] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:D] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:E] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:F] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:Read_Oil] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:PeakDetectChl] Running Loop=1
2020-12-13T15:57:31.855Z,1607875051.855 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectChl
2020-12-13T15:57:31.868Z,1607875051.868 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2020-12-13T15:57:31.868Z,1607875051.868 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-12-13T15:57:31.869Z,1607875051.869 [profile_station:Science:HighestChlPeakReport] Running Loop=1
2020-12-13T15:57:31.869Z,1607875051.869 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize profile_station:Science:HighestChlPeakReport
2020-12-13T15:57:31.869Z,1607875051.869 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2020-12-13T15:57:31.869Z,1607875051.869 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2020-12-13T15:57:31.870Z,1607875051.870 [profile_station:Science:PeakDetectNO3] Running Loop=1
2020-12-13T15:57:31.870Z,1607875051.870 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectNO3
2020-12-13T15:57:31.870Z,1607875051.870 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2020-12-13T15:57:31.870Z,1607875051.870 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-12-13T15:57:31.871Z,1607875051.871 [profile_station:Science:PeakDetectOil] Running Loop=1
2020-12-13T15:57:31.871Z,1607875051.871 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectOil
2020-12-13T15:57:31.871Z,1607875051.871 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2020-12-13T15:57:31.871Z,1607875051.871 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-12-13T15:57:31.885Z,1607875051.885 [profile_station:Science:PeakDetectFDOM] Running Loop=1
2020-12-13T15:57:31.885Z,1607875051.885 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectFDOM
2020-12-13T15:57:31.885Z,1607875051.885 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2020-12-13T15:57:31.885Z,1607875051.885 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-12-13T15:57:31.886Z,1607875051.886 [profile_station:Science:OceanCurrent] Running Loop=1
2020-12-13T15:57:31.886Z,1607875051.886 [profile_station:Science:OceanCurrent](DEBUG): Aggregate::initialize profile_station:Science:OceanCurrent
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:Science:OceanCurrent:A.] Running Loop=1
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes] Running Loop=1
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes](DEBUG): Aggregate::initialize profile_station:StandardEnvelopes
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2020-12-13T15:57:31.887Z,1607875051.887 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2020-12-13T15:57:31.900Z,1607875051.900 [profile_station:I.Pitch] Running Loop=1
2020-12-13T15:57:31.900Z,1607875051.900 [profile_station:I.Pitch](DEBUG): Initialize.
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:J.Buoyancy] Running Loop=1
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:J.Buoyancy](DEBUG): Initialize Buoyancy Component.
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:K.SetSpeed] Running Loop=1
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:K.SetSpeed](DEBUG): Initialize.
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:L.DepthEnvelope] Running Loop=1
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:M.AltitudeEnvelope] Running Loop=1
2020-12-13T15:57:31.901Z,1607875051.901 [profile_station:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2020-12-13T15:57:31.902Z,1607875051.902 [profile_station:N.YoYo] Running Loop=1
2020-12-13T15:57:31.902Z,1607875051.902 [profile_station:N.YoYo](DEBUG): Initialize YoYoComponent.
2020-12-13T15:57:31.902Z,1607875051.902 [profile_station:C] Running Loop=1
2020-12-13T15:57:31.902Z,1607875051.902 [profile_station:N.YoYo] Running Loop=1
2020-12-13T15:57:31.903Z,1607875051.903 [profile_station:M.AltitudeEnvelope] Running Loop=1
2020-12-13T15:57:31.903Z,1607875051.903 [profile_station:L.DepthEnvelope] Running Loop=1
2020-12-13T15:57:31.916Z,1607875051.916 [profile_station:K.SetSpeed] Running Loop=1
2020-12-13T15:57:31.916Z,1607875051.916 [profile_station:J.Buoyancy] Running Loop=1
2020-12-13T15:57:31.917Z,1607875051.917 [profile_station:I.Pitch] Running Loop=1
2020-12-13T15:57:31.917Z,1607875051.917 [profile_station:StandardEnvelopes] Running Loop=1
2020-12-13T15:57:31.917Z,1607875051.917 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2020-12-13T15:57:31.917Z,1607875051.917 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2020-12-13T15:57:31.918Z,1607875051.918 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2020-12-13T15:57:31.918Z,1607875051.918 [profile_station:C] Stopped
2020-12-13T15:57:31.918Z,1607875051.918 [profile_station:E] Running Loop=1
2020-12-13T15:57:31.918Z,1607875051.918 [profile_station:Science] Running Loop=1
2020-12-13T15:57:31.919Z,1607875051.919 [profile_station:Science:PeakDetectFDOM] Stopped
2020-12-13T15:57:31.919Z,1607875051.919 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectFDOM
2020-12-13T15:57:31.919Z,1607875051.919 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2020-12-13T15:57:31.919Z,1607875051.919 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectOil] Stopped
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectOil
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectNO3] Stopped
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectNO3
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-12-13T15:57:31.932Z,1607875051.932 [profile_station:Science:HighestChlPeakReport] Stopped
2020-12-13T15:57:31.933Z,1607875051.933 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize profile_station:Science:HighestChlPeakReport
2020-12-13T15:57:31.933Z,1607875051.933 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2020-12-13T15:57:31.933Z,1607875051.933 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2020-12-13T15:57:31.933Z,1607875051.933 [profile_station:Science:PeakDetectChl] Running Loop=1
2020-12-13T15:57:31.933Z,1607875051.933 [profile_station:Science:OceanCurrent:A.] Running Loop=1
2020-12-13T15:57:31.934Z,1607875051.934 [profile_station:Science:Read_Oil] Running Loop=1
2020-12-13T15:57:31.934Z,1607875051.934 [profile_station:Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2020-12-13T15:57:31.935Z,1607875051.935 [profile_station:Science:F] Stopped
2020-12-13T15:57:31.935Z,1607875051.935 [profile_station:Science:E] Running Loop=1
2020-12-13T15:57:31.935Z,1607875051.935 [profile_station:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2020-12-13T15:57:31.935Z,1607875051.935 [profile_station:Science:D] Stopped
2020-12-13T15:57:31.935Z,1607875051.935 [profile_station:Science:C] Running Loop=1
2020-12-13T15:57:31.948Z,1607875051.948 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2020-12-13T15:57:31.965Z,1607875051.965 [profile_station:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2020-12-13T15:57:31.965Z,1607875051.965 [profile_station:Science:B] Running Loop=1
2020-12-13T15:57:31.966Z,1607875051.966 [profile_station:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2020-12-13T15:57:31.966Z,1607875051.966 [profile_station:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2020-12-13T15:57:31.966Z,1607875051.966 [profile_station:Science:A] Stopped
2020-12-13T15:57:32.215Z,1607875052.215 [profile_station:E] Stopped
2020-12-13T15:57:32.215Z,1607875052.215 [profile_station:F] Running Loop=1
2020-12-13T15:57:32.244Z,1607875052.244 [WetLabsSeaOWL_UV_A](INFO): Powering up
2020-12-13T15:57:32.601Z,1607875052.601 [profile_station:F] Stopped
2020-12-13T15:57:32.602Z,1607875052.602 [profile_station:G] Running Loop=1
2020-12-13T15:57:32.992Z,1607875052.992 [profile_station:G] Stopped
2020-12-13T15:57:32.992Z,1607875052.992 [profile_station:StartingMission] Running Loop=1
2020-12-13T15:57:32.992Z,1607875052.992 [profile_station:StartingMission](DEBUG): Aggregate::initialize profile_station:StartingMission
2020-12-13T15:57:33.444Z,1607875053.444 [profile_station:NeedComms] Running Loop=1
2020-12-13T15:57:33.444Z,1607875053.444 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms
2020-12-13T15:57:33.445Z,1607875053.445 [profile_station:NeedComms:B.GoToSurface] Running Loop=1
2020-12-13T15:57:33.445Z,1607875053.445 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-13T15:57:33.445Z,1607875053.445 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2020-12-13T15:57:33.445Z,1607875053.445 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2020-12-13T15:57:33.446Z,1607875053.446 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2020-12-13T15:57:33.446Z,1607875053.446 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-13T15:57:33.446Z,1607875053.446 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-13T15:57:33.447Z,1607875053.447 [profile_station:NeedComms:A] Running Loop=1
2020-12-13T15:57:33.456Z,1607875053.456 [profile_station:NeedComms:A](INFO): last time_fix was: 1607874960.000000 second since 1970/01/01T00:00:00Z 
2020-12-13T15:57:33.456Z,1607875053.456 [profile_station:NeedComms:A] Stopped
2020-12-13T15:57:33.776Z,1607875053.776 [profile_station:NeedComms:C] Running Loop=1
2020-12-13T15:57:34.213Z,1607875054.213 [profile_station:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-12-13T15:57:35.473Z,1607875055.473 [CTD_Seabird](ERROR): Failed to parse device response: <!--startlogging-->
2020-12-13T15:57:35.772Z,1607875055.772 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155735.00,A,4133.80703,N,07041.99920,W,0.583,198.66,131220,,,A*71
2020-12-13T15:57:35.774Z,1607875055.774 [NAL9602](INFO): GPS fix at 20201213T155735: (41.563451, -70.699987)
2020-12-13T15:57:35.809Z,1607875055.809 [profile_station:NeedComms:C] Stopped
2020-12-13T15:57:35.810Z,1607875055.810 [profile_station:NeedComms:D] Running Loop=1
2020-12-13T15:57:36.205Z,1607875056.205 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T15:57:36.281Z,1607875056.281 [profile_station:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-12-13T15:57:40.301Z,1607875060.301 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20201213T154932/Courier0009.lzma
2020-12-13T15:57:41.162Z,1607875061.162 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T15:57:41.294Z,1607875061.294 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Courier0009.lzma.bak
2020-12-13T15:57:41.294Z,1607875061.294 [DataOverHttps](INFO): SBD MOMSN=64623
2020-12-13T15:57:50.074Z,1607875070.074 [NAL9602](INFO): SBD MO Status=0, MOMSN=12788, MT Status=0, MTMSN=0
2020-12-13T15:57:50.074Z,1607875070.074 [NAL9602](INFO): No messages in MT queue
2020-12-13T15:57:50.337Z,1607875070.337 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20201213T154932/Courier0012.lzma
2020-12-13T15:57:51.334Z,1607875071.334 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Courier0012.lzma.bak
2020-12-13T15:57:51.334Z,1607875071.334 [DataOverHttps](INFO): SBD MOMSN=64626
2020-12-13T15:58:00.392Z,1607875080.392 [DataOverHttps](INFO): Sending 568 bytes from file Logs/20201213T154932/Express0010.lzma
2020-12-13T15:58:01.394Z,1607875081.394 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0010.lzma.bak
2020-12-13T15:58:01.394Z,1607875081.394 [DataOverHttps](INFO): SBD MOMSN=64628
2020-12-13T15:58:10.433Z,1607875090.433 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20201213T154932/Express0013.lzma
2020-12-13T15:58:11.434Z,1607875091.434 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0013.lzma.bak
2020-12-13T15:58:11.434Z,1607875091.434 [DataOverHttps](INFO): SBD MOMSN=64653
2020-12-13T15:58:12.715Z,1607875092.715 [profile_station:NeedComms:D] Stopped
2020-12-13T15:58:12.715Z,1607875092.715 [profile_station:NeedComms:E] Running Loop=1
2020-12-13T15:58:13.160Z,1607875093.160 [profile_station:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-12-13T15:58:14.708Z,1607875094.708 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,155814.00,A,4133.80551,N,07041.99952,W,0.894,208.32,131220,,,A*7D
2020-12-13T15:58:14.710Z,1607875094.710 [NAL9602](INFO): GPS fix at 20201213T155814: (41.563425, -70.699992)
2020-12-13T15:58:14.723Z,1607875094.723 [profile_station:NeedComms:E] Stopped
2020-12-13T15:58:14.724Z,1607875094.724 [profile_station:NeedComms](INFO): Completed profile_station:NeedComms
2020-12-13T15:58:14.724Z,1607875094.724 [profile_station:NeedComms] Stopped
2020-12-13T15:58:14.724Z,1607875094.724 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms
2020-12-13T15:58:14.725Z,1607875094.725 [profile_station:NeedComms:B.GoToSurface] Stopped
2020-12-13T15:58:14.725Z,1607875094.725 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-13T15:58:15.191Z,1607875095.191 [profile_station:StartingMission](INFO): Completed profile_station:StartingMission
2020-12-13T15:58:15.191Z,1607875095.191 [profile_station:StartingMission] Stopped
2020-12-13T15:58:15.191Z,1607875095.191 [profile_station:StartingMission](DEBUG): Aggregate::uninitialize profile_station:StartingMission
2020-12-13T15:58:15.196Z,1607875095.196 [profile_station:CircleWrapper] Running Loop=1
2020-12-13T15:58:15.197Z,1607875095.197 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper
2020-12-13T15:58:15.197Z,1607875095.197 [profile_station:CircleWrapper:A] Running Loop=1
2020-12-13T15:58:15.197Z,1607875095.197 [profile_station:CircleWrapper:B.Circle] Running Loop=1
2020-12-13T15:58:15.197Z,1607875095.197 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent.
2020-12-13T15:58:15.519Z,1607875095.519 [profile_station:CircleWrapper:A] Running Loop=1
2020-12-13T15:58:16.334Z,1607875096.334 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T15:58:47.461Z,1607875127.461 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T15:58:56.349Z,1607875136.349 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T15:59:01.232Z,1607875141.232 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T15:59:06.450Z,1607875146.450 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T15:59:16.197Z,1607875156.197 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T15:59:26.253Z,1607875166.253 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T15:59:26.259Z,1607875166.259 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch -10.00 deg, mass-position -0.36 mm (5 active estimators).
2020-12-13T15:59:31.171Z,1607875171.171 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T15:59:51.309Z,1607875191.309 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T15:59:52.841Z,1607875192.841 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.244175
2020-12-13T16:00:11.530Z,1607875211.530 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 10.00 deg, mass-position -0.36 mm (6 active estimators).
2020-12-13T16:00:26.548Z,1607875226.548 [Radio_Surface](INFO): Powering down
2020-12-13T16:00:28.991Z,1607875228.991 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T16:00:29.993Z,1607875229.993 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-12-13T16:04:56.332Z,1607875496.332 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:05:05.354Z,1607875505.354 [CTD_Seabird](ERROR): Failed to parse device response: 4.80,0
2020-12-13T16:09:16.106Z,1607875756.106 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:10:14.298Z,1607875814.298 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T16:10:55.095Z,1607875855.095 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:12:14.287Z,1607875934.287 [RDI_PathfinderUp](ERROR): only read 0 of 4 data items
2020-12-13T16:15:17.281Z,1607876117.281 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:15:47.179Z,1607876147.179 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:15:52.077Z,1607876152.077 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:16:02.162Z,1607876162.162 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:16:06.179Z,1607876166.179 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:16:07.379Z,1607876167.379 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:16:12.232Z,1607876172.232 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-12-13T16:16:17.087Z,1607876177.087 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:16:22.332Z,1607876182.332 [RDI_Pathfinder](ERROR): only read 1 of 4 data items
2020-12-13T16:16:27.200Z,1607876187.200 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout
2020-12-13T16:16:27.200Z,1607876187.200 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-12-13T16:16:27.200Z,1607876187.200 [RDI_Pathfinder](ERROR): Communications Fault
2020-12-13T16:16:27.316Z,1607876187.316 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-12-13T16:16:27.664Z,1607876187.664 [RDI_Pathfinder](INFO): Powering down
2020-12-13T16:16:28.484Z,1607876188.484 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-12-13T16:16:28.484Z,1607876188.484 [RDI_Pathfinder] No Fault, FailCount= 1
2020-12-13T16:16:33.221Z,1607876193.221 [CTD_Seabird](ERROR): Failed to parse device response: 5.56,7.502.76
2020-12-13T16:17:13.477Z,1607876233.477 [CTD_Seabird](ERROR): Failed to parse device response: 4.90,7
4.88,7.4847,3.27788,6179.44
2020-12-13T16:17:52.444Z,1607876272.444 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T16:18:22.335Z,1607876302.335 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:18:27.173Z,1607876307.173 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:18:52.227Z,1607876332.227 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T16:19:52.410Z,1607876392.410 [Micromodem](ERROR): Response from modem failed NMEA checksum: 0.0.46*4A
 expected 0
2020-12-13T16:24:09.772Z,1607876649.772 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-12-13T16:24:09.775Z,1607876649.775 [BPC1](INFO): Received data from all battery sticks.
2020-12-13T16:28:03.681Z,1607876883.681 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:28:42.879Z,1607876922.879 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:28:47.737Z,1607876927.737 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:28:52.974Z,1607876932.974 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:28:57.841Z,1607876937.841 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:29:07.937Z,1607876947.937 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T16:29:18.840Z,1607876958.840 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:32:45.685Z,1607877165.685 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T16:34:05.267Z,1607877245.267 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T16:38:33.159Z,1607877513.159 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:38:43.240Z,1607877523.240 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:38:48.475Z,1607877528.475 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:38:53.332Z,1607877533.332 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T16:38:58.171Z,1607877538.171 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:39:03.438Z,1607877543.438 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:39:08.283Z,1607877548.283 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T16:40:18.063Z,1607877618.063 [CTD_Seabird](ERROR): Failed to parse device response: .76
2020-12-13T16:44:44.413Z,1607877884.413 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:47:15.639Z,1607878035.639 [ThrusterServo](FAULT): getVelocity uart error serial timeout
2020-12-13T16:47:15.640Z,1607878035.640 [ThrusterServo](FAULT): Thruster uart error: serial timeout
2020-12-13T16:47:15.640Z,1607878035.640 [ThrusterServo] Communications Fault, FailCount= 1
2020-12-13T16:47:15.640Z,1607878035.640 [ThrusterServo](ERROR): Communications Fault
2020-12-13T16:47:15.658Z,1607878035.658 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2020-12-13T16:47:15.953Z,1607878035.953 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-12-13T16:47:15.953Z,1607878035.953 [ThrusterServo](INFO): Powering down
2020-12-13T16:47:16.773Z,1607878036.773 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-12-13T16:47:16.889Z,1607878036.889 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-12-13T16:47:16.893Z,1607878036.893 [CBIT](INFO): Clearing failed state for component ThrusterServo
2020-12-13T16:47:16.893Z,1607878036.893 [ThrusterServo] No Fault, FailCount= 1
2020-12-13T16:48:58.926Z,1607878138.926 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:49:03.795Z,1607878143.795 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:49:08.681Z,1607878148.681 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T16:49:13.875Z,1607878153.875 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:49:23.993Z,1607878163.993 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:49:28.833Z,1607878168.833 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:49:33.694Z,1607878173.694 [RDI_Pathfinder](ERROR): only read 1 of 4 data items
2020-12-13T16:49:38.927Z,1607878178.927 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:49:53.890Z,1607878193.890 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T16:51:34.472Z,1607878294.472 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T16:58:07.977Z,1607878687.977 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:58:15.275Z,1607878695.275 [profile_station:NeedComms] Running Loop=1
2020-12-13T16:58:15.275Z,1607878695.275 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms
2020-12-13T16:58:15.275Z,1607878695.275 [profile_station:NeedComms:B.GoToSurface] Running Loop=1
2020-12-13T16:58:15.292Z,1607878695.292 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-13T16:58:15.292Z,1607878695.292 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2020-12-13T16:58:15.292Z,1607878695.292 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2020-12-13T16:58:15.293Z,1607878695.293 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2020-12-13T16:58:15.293Z,1607878695.293 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-13T16:58:15.293Z,1607878695.293 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-13T16:58:15.294Z,1607878695.294 [profile_station:NeedComms:A] Running Loop=1
2020-12-13T16:58:15.295Z,1607878695.295 [profile_station:NeedComms:A](INFO): last time_fix was: 1607875094.000000 second since 1970/01/01T00:00:00Z 
2020-12-13T16:58:15.295Z,1607878695.295 [profile_station:NeedComms:A] Stopped
2020-12-13T16:58:44.419Z,1607878724.419 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T16:58:48.859Z,1607878728.859 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T16:58:53.747Z,1607878733.747 [profile_station:NeedComms:C] Running Loop=1
2020-12-13T16:58:54.364Z,1607878734.364 [Radio_Surface](INFO): Powering up
2020-12-13T16:59:00.477Z,1607878740.477 [DataOverHttps](INFO): Radio surface powered ON.
2020-12-13T16:59:04.222Z,1607878744.222 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T16:59:13.105Z,1607878753.105 [NAL9602](INFO): SBD MO Status=0, MOMSN=12789, MT Status=0, MTMSN=0
2020-12-13T16:59:13.106Z,1607878753.106 [NAL9602](INFO): No messages in MT queue
2020-12-13T16:59:14.316Z,1607878754.316 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165913.00,A,4134.33544,N,07041.28880,W,0.564,0.00,131220,,,A*7E
2020-12-13T16:59:14.318Z,1607878754.318 [NAL9602](INFO): GPS fix at 20201213T165913: (41.572257, -70.688147)
2020-12-13T16:59:14.325Z,1607878754.325 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T16:59:14.335Z,1607878754.335 [UniversalFixResidualReporter](INFO): Fix residual: 5.2 %DT, over the last 2213.3 m. Residual distance 115.5 m at bearing -69.4 degrees. Fix at (41.5723, -70.6881) with 1391.3 m made good.
2020-12-13T16:59:14.341Z,1607878754.341 [profile_station:NeedComms:C] Stopped
2020-12-13T16:59:14.341Z,1607878754.341 [profile_station:NeedComms:D] Running Loop=1
2020-12-13T16:59:30.604Z,1607878770.604 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T16:59:33.540Z,1607878773.540 [NAL9602](INFO): SBD MO Status=1, MOMSN=12790, MT Status=0, MTMSN=0
2020-12-13T16:59:33.588Z,1607878773.588 [NAL9602](INFO): Sent 184 bytes from file Logs/20201213T154932/Courier0015.lzma
2020-12-13T16:59:33.588Z,1607878773.588 [NAL9602](INFO): Packets left to send: 1
2020-12-13T16:59:41.744Z,1607878781.744 [NAL9602](INFO): SBD MO Status=1, MOMSN=12791, MT Status=0, MTMSN=0
2020-12-13T16:59:41.796Z,1607878781.796 [NAL9602](INFO): Sent 87 bytes from file Logs/20201213T154932/Courier0015.lzma
2020-12-13T16:59:41.796Z,1607878781.796 [NAL9602](INFO): Packets left to send: 0
2020-12-13T16:59:53.286Z,1607878793.286 [NAL9602](INFO): SBD MO Status=1, MOMSN=12792, MT Status=0, MTMSN=0
2020-12-13T16:59:53.340Z,1607878793.340 [NAL9602](INFO): Sent 184 bytes from file Logs/20201213T154932/Express0016.lzma
2020-12-13T16:59:53.340Z,1607878793.340 [NAL9602](INFO): Packets left to send: 3
2020-12-13T17:00:04.796Z,1607878804.796 [NAL9602](INFO): SBD MO Status=1, MOMSN=12793, MT Status=0, MTMSN=0
2020-12-13T17:00:04.847Z,1607878804.847 [NAL9602](INFO): Sent 184 bytes from file Logs/20201213T154932/Express0016.lzma
2020-12-13T17:00:04.847Z,1607878804.847 [NAL9602](INFO): Packets left to send: 2
2020-12-13T17:00:05.744Z,1607878805.744 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T17:00:13.288Z,1607878813.288 [NAL9602](INFO): SBD MO Status=1, MOMSN=12794, MT Status=0, MTMSN=0
2020-12-13T17:00:13.357Z,1607878813.357 [NAL9602](INFO): Sent 184 bytes from file Logs/20201213T154932/Express0016.lzma
2020-12-13T17:00:13.357Z,1607878813.357 [NAL9602](INFO): Packets left to send: 1
2020-12-13T17:00:21.183Z,1607878821.183 [NAL9602](INFO): SBD MO Status=1, MOMSN=12795, MT Status=0, MTMSN=0
2020-12-13T17:00:21.232Z,1607878821.232 [NAL9602](INFO): Sent 26 bytes from file Logs/20201213T154932/Express0016.lzma
2020-12-13T17:00:21.232Z,1607878821.232 [NAL9602](INFO): Packets left to send: 0
2020-12-13T17:00:30.896Z,1607878830.896 [NAL9602](INFO): SBD MO Status=0, MOMSN=12796, MT Status=0, MTMSN=0
2020-12-13T17:00:34.124Z,1607878834.124 [CTD_Seabird](ERROR): Failed to parse device response: ,7.5857,3.27937,4479.60
2020-12-13T17:00:38.967Z,1607878838.967 [NAL9602](INFO): SBD MO Status=0, MOMSN=12797, MT Status=0, MTMSN=0
2020-12-13T17:00:40.884Z,1607878840.884 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T17:00:47.401Z,1607878847.401 [NAL9602](INFO): SBD MO Status=0, MOMSN=12798, MT Status=0, MTMSN=0
2020-12-13T17:00:57.900Z,1607878857.900 [NAL9602](INFO): SBD MO Status=0, MOMSN=12799, MT Status=0, MTMSN=0
2020-12-13T17:01:11.227Z,1607878871.227 [NAL9602](INFO): SBD MO Status=0, MOMSN=12800, MT Status=0, MTMSN=0
2020-12-13T17:01:16.033Z,1607878876.033 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T17:01:30.218Z,1607878890.218 [NAL9602](INFO): SBD MO Status=2, MOMSN=12801, MT Status=2, MTMSN=0
2020-12-13T17:01:30.218Z,1607878890.218 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-12-13T17:01:40.720Z,1607878900.720 [NAL9602](INFO): SBD MO Status=0, MOMSN=12801, MT Status=0, MTMSN=0
2020-12-13T17:01:50.420Z,1607878910.420 [NAL9602](INFO): SBD MO Status=0, MOMSN=12802, MT Status=0, MTMSN=0
2020-12-13T17:01:51.172Z,1607878911.172 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T17:02:07.387Z,1607878927.387 [NAL9602](INFO): SBD MO Status=0, MOMSN=12803, MT Status=0, MTMSN=0
2020-12-13T17:02:17.083Z,1607878937.083 [NAL9602](INFO): SBD MO Status=0, MOMSN=12804, MT Status=0, MTMSN=0
2020-12-13T17:02:19.524Z,1607878939.524 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:02:20.305Z,1607878940.305 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.015368
2020-12-13T17:02:21.633Z,1607878941.633 [profile_station:NeedComms:D] Stopped
2020-12-13T17:02:21.633Z,1607878941.633 [profile_station:NeedComms:E] Running Loop=1
2020-12-13T17:02:27.183Z,1607878947.183 [NAL9602](INFO): SBD MO Status=0, MOMSN=12805, MT Status=0, MTMSN=0
2020-12-13T17:02:28.396Z,1607878948.396 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,170227.00,A,4134.33268,N,07041.28496,W,0.292,0.00,131220,,,A*7A
2020-12-13T17:02:28.398Z,1607878948.398 [NAL9602](INFO): GPS fix at 20201213T170227: (41.572211, -70.688083)
2020-12-13T17:02:28.450Z,1607878948.450 [profile_station:NeedComms:E] Stopped
2020-12-13T17:02:28.451Z,1607878948.451 [profile_station:NeedComms](INFO): Completed profile_station:NeedComms
2020-12-13T17:02:28.451Z,1607878948.451 [profile_station:NeedComms] Stopped
2020-12-13T17:02:28.451Z,1607878948.451 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms
2020-12-13T17:02:28.451Z,1607878948.451 [profile_station:NeedComms:B.GoToSurface] Stopped
2020-12-13T17:02:28.456Z,1607878948.456 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-13T17:02:39.519Z,1607878959.519 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:02:49.623Z,1607878969.623 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T17:02:50.846Z,1607878970.846 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:03:00.930Z,1607878980.930 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T17:03:04.999Z,1607878984.999 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T17:05:11.993Z,1607879111.993 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.250832
2020-12-13T17:05:25.104Z,1607879125.104 [Radio_Surface](INFO): Powering down
2020-12-13T17:05:48.137Z,1607879148.137 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T17:05:49.141Z,1607879149.141 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2020-12-13T17:08:12.467Z,1607879292.467 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:08:54.877Z,1607879334.877 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:09:04.973Z,1607879344.973 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:09:09.837Z,1607879349.837 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:09:19.935Z,1607879359.935 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:09:29.672Z,1607879369.672 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T17:09:34.878Z,1607879374.878 [RDI_Pathfinder](ERROR): only read 1 of 4 data items
2020-12-13T17:09:54.702Z,1607879394.702 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:12:53.667Z,1607879573.667 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:17:04.185Z,1607879824.185 [profile_station:CircleWrapper:B.Circle] Stopped
2020-12-13T17:17:04.185Z,1607879824.185 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize.
2020-12-13T17:17:04.186Z,1607879824.186 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper
2020-12-13T17:17:04.186Z,1607879824.186 [profile_station:CircleWrapper] Stopped
2020-12-13T17:17:04.186Z,1607879824.186 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper
2020-12-13T17:17:04.186Z,1607879824.186 [profile_station:CircleWrapper:A] Stopped
2020-12-13T17:17:04.186Z,1607879824.186 [profile_station:CircleWrapper](INFO): Running loop #2
2020-12-13T17:17:04.186Z,1607879824.186 [profile_station:CircleWrapper] Running Loop=2
2020-12-13T17:17:04.187Z,1607879824.187 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper
2020-12-13T17:17:04.187Z,1607879824.187 [profile_station:CircleWrapper:A] Running Loop=1
2020-12-13T17:17:04.187Z,1607879824.187 [profile_station:CircleWrapper:B.Circle] Running Loop=1
2020-12-13T17:17:04.187Z,1607879824.187 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent.
2020-12-13T17:18:55.230Z,1607879935.230 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:19:00.476Z,1607879940.476 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:19:04.927Z,1607879944.927 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T17:19:05.327Z,1607879945.327 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:19:10.170Z,1607879950.170 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:19:15.430Z,1607879955.430 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T17:19:20.271Z,1607879960.271 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:19:30.378Z,1607879970.378 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:19:35.237Z,1607879975.237 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:21:39.341Z,1607880099.341 [CTD_Seabird](ERROR): Failed to parse device response: 6.10,7.484.74
2020-12-13T17:26:07.511Z,1607880367.511 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:26:19.231Z,1607880379.231 [RDI_PathfinderUp](ERROR): only read 0 of 4 data items
2020-12-13T17:27:57.897Z,1607880477.897 [CTD_Seabird](ERROR): Failed to parse device response: ,7.4662,3.27258,6504.49
2020-12-13T17:28:30.927Z,1607880510.927 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:28:55.982Z,1607880535.982 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:28:59.649Z,1607880539.649 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:29:00.840Z,1607880540.840 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:29:15.800Z,1607880555.800 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout
2020-12-13T17:29:15.800Z,1607880555.800 [RDI_Pathfinder] Communications Fault, FailCount= 1
2020-12-13T17:29:15.800Z,1607880555.800 [RDI_Pathfinder](ERROR): Communications Fault
2020-12-13T17:29:16.149Z,1607880556.149 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2020-12-13T17:29:16.244Z,1607880556.244 [RDI_Pathfinder](INFO): Powering down
2020-12-13T17:29:17.040Z,1607880557.040 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2020-12-13T17:29:17.041Z,1607880557.041 [RDI_Pathfinder] No Fault, FailCount= 1
2020-12-13T17:30:11.162Z,1607880611.162 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:30:20.485Z,1607880620.485 [CTD_Seabird](ERROR): Failed to parse device response: 74,6167.57
2020-12-13T17:31:10.186Z,1607880670.186 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:31:32.332Z,1607880692.332 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-12-13T17:31:32.334Z,1607880692.334 [BPC1](INFO): Received data from all battery sticks.
2020-12-13T17:34:05.491Z,1607880845.491 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:36:14.350Z,1607880974.350 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:37:03.634Z,1607881023.634 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T17:37:05.273Z,1607881025.273 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:38:46.299Z,1607881126.299 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:39:01.203Z,1607881141.203 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:39:06.481Z,1607881146.481 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:39:10.491Z,1607881150.491 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:39:21.412Z,1607881161.412 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:39:36.352Z,1607881176.352 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:39:41.191Z,1607881181.191 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:39:46.471Z,1607881186.471 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T17:39:51.306Z,1607881191.306 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T17:39:54.523Z,1607881194.523 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:40:56.347Z,1607881256.347 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T17:40:57.566Z,1607881257.566 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:41:21.390Z,1607881281.390 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:41:26.295Z,1607881286.295 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:41:31.502Z,1607881291.502 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T17:41:41.610Z,1607881301.610 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:41:56.550Z,1607881316.550 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:42:06.297Z,1607881326.297 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:42:16.347Z,1607881336.347 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:45:51.291Z,1607881551.291 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:52:46.584Z,1607881966.584 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-12-13T17:54:58.322Z,1607882098.322 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T17:58:54.295Z,1607882334.295 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T17:59:27.404Z,1607882367.404 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T17:59:42.352Z,1607882382.352 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T17:59:52.471Z,1607882392.471 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T18:00:02.194Z,1607882402.194 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T18:00:07.411Z,1607882407.411 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T18:00:12.277Z,1607882412.277 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T18:00:22.351Z,1607882422.351 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T18:00:27.189Z,1607882427.189 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T18:02:02.522Z,1607882522.522 [RDI_Pathfinder](ERROR): DVL BIT error. See manual. Result code: 70
2020-12-13T18:02:07.373Z,1607882527.373 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T18:02:17.496Z,1607882537.496 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-12-13T18:02:22.323Z,1607882542.323 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-12-13T18:02:24.384Z,1607882544.384 [profile_station:CircleWrapper:B.Circle] Stopped
2020-12-13T18:02:24.384Z,1607882544.384 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize.
2020-12-13T18:02:24.385Z,1607882544.385 [profile_station:CircleWrapper](INFO): Completed profile_station:CircleWrapper
2020-12-13T18:02:24.385Z,1607882544.385 [profile_station:CircleWrapper] Stopped
2020-12-13T18:02:24.385Z,1607882544.385 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper
2020-12-13T18:02:24.385Z,1607882544.385 [profile_station:CircleWrapper:A] Stopped
2020-12-13T18:02:24.385Z,1607882544.385 [profile_station:CircleWrapper](INFO): Running loop #3
2020-12-13T18:02:24.386Z,1607882544.386 [profile_station:CircleWrapper] Running Loop=3
2020-12-13T18:02:24.386Z,1607882544.386 [profile_station:CircleWrapper](DEBUG): Aggregate::initialize profile_station:CircleWrapper
2020-12-13T18:02:24.386Z,1607882544.386 [profile_station:CircleWrapper:A] Running Loop=1
2020-12-13T18:02:24.386Z,1607882544.386 [profile_station:CircleWrapper:B.Circle] Running Loop=1
2020-12-13T18:02:24.386Z,1607882544.386 [profile_station:CircleWrapper:B.Circle](DEBUG): Initialize CircleComponent.
2020-12-13T18:02:32.426Z,1607882552.426 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T18:02:51.821Z,1607882571.821 [profile_station:NeedComms] Running Loop=1
2020-12-13T18:02:51.821Z,1607882571.821 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms
2020-12-13T18:02:51.821Z,1607882571.821 [profile_station:NeedComms:B.GoToSurface] Running Loop=1
2020-12-13T18:02:51.822Z,1607882571.822 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-13T18:02:51.822Z,1607882571.822 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2020-12-13T18:02:51.822Z,1607882571.822 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2020-12-13T18:02:51.823Z,1607882571.823 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2020-12-13T18:02:51.823Z,1607882571.823 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-13T18:02:51.823Z,1607882571.823 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-13T18:02:51.824Z,1607882571.824 [profile_station:NeedComms:A] Running Loop=1
2020-12-13T18:02:51.825Z,1607882571.825 [profile_station:NeedComms:A](INFO): last time_fix was: 1607878947.000000 second since 1970/01/01T00:00:00Z 
2020-12-13T18:02:51.825Z,1607882571.825 [profile_station:NeedComms:A] Stopped
2020-12-13T18:02:58.300Z,1607882578.300 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T18:03:25.814Z,1607882605.814 [profile_station:NeedComms:C] Running Loop=1
2020-12-13T18:03:26.524Z,1607882606.524 [Radio_Surface](INFO): Powering up
2020-12-13T18:03:32.612Z,1607882612.612 [DataOverHttps](INFO): Radio surface powered ON.
2020-12-13T18:03:59.701Z,1607882639.701 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=12806, MT Status=1, MTMSN=526
2020-12-13T18:03:59.701Z,1607882639.701 [NAL9602](INFO): Data available in MT queue
2020-12-13T18:04:00.224Z,1607882640.224 [NAL9602](INFO): Received command:stop
2020-12-13T18:04:00.292Z,1607882640.292 [CommandLine](IMPORTANT): got command stop
2020-12-13T18:04:00.292Z,1607882640.292 [CommandLine](IMPORTANT): Scheduling is paused
2020-12-13T18:04:00.293Z,1607882640.293 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2020-12-13T18:04:00.307Z,1607882640.307 [MissionManager](INFO): MissionManager is completed.
2020-12-13T18:04:00.307Z,1607882640.307 [MissionManager](INFO): Uninitializing Mission profile_station
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station] Stopped
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station](DEBUG): Aggregate::uninitialize profile_station
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science] Stopped
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science](DEBUG): Aggregate::uninitialize profile_station:Science
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science:B] Stopped
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science:C] Stopped
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science:E] Stopped
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science:Read_Oil] Stopped
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science:OceanCurrent] Stopped
2020-12-13T18:04:00.307Z,1607882640.307 [profile_station:Science:OceanCurrent](DEBUG): Aggregate::uninitialize profile_station:Science:OceanCurrent
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:Science:OceanCurrent:A.] Stopped
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:Science:PeakDetectChl] Stopped
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectChl
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:NeedComms] Stopped
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:NeedComms:B.GoToSurface] Stopped
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-13T18:04:00.312Z,1607882640.312 [profile_station:NeedComms:C] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes](DEBUG): Aggregate::uninitialize profile_station:StandardEnvelopes
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes:B.DepthEnvelope] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:I.Pitch] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:J.Buoyancy] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:K.SetSpeed] Stopped
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:K.SetSpeed](DEBUG): Uninitialize.
2020-12-13T18:04:00.313Z,1607882640.313 [profile_station:L.DepthEnvelope] Stopped
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:L.DepthEnvelope](DEBUG): Uninitialize.
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:M.AltitudeEnvelope] Stopped
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:N.YoYo] Stopped
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:N.YoYo](DEBUG): Uninitialize YoYoComponent.
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:CircleWrapper] Stopped
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:CircleWrapper](DEBUG): Aggregate::uninitialize profile_station:CircleWrapper
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:CircleWrapper:A] Stopped
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:CircleWrapper:B.Circle] Stopped
2020-12-13T18:04:00.314Z,1607882640.314 [profile_station:CircleWrapper:B.Circle](DEBUG): Uninitialize.
2020-12-13T18:04:00.583Z,1607882640.583 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-12-13T18:04:00.583Z,1607882640.583 [DefaultWithUndock] Running Loop=1
2020-12-13T18:04:00.583Z,1607882640.583 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-12-13T18:04:00.583Z,1607882640.583 [DefaultWithUndock:A.Wait] Running Loop=1
2020-12-13T18:04:00.583Z,1607882640.583 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-12-13T18:04:00.784Z,1607882640.784 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-12-13T18:04:02.732Z,1607882642.732 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T18:04:30.851Z,1607882670.851 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T18:04:30.864Z,1607882670.864 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-12-13T18:04:30.864Z,1607882670.864 [DefaultWithUndock:A.Wait] Stopped
2020-12-13T18:04:30.864Z,1607882670.864 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T18:04:30.865Z,1607882670.865 [DefaultWithUndock:LeaveDock] Running Loop=1
2020-12-13T18:04:30.865Z,1607882670.865 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::initialize DefaultWithUndock:LeaveDock
2020-12-13T18:04:30.865Z,1607882670.865 [DefaultWithUndock:LeaveDock:A.] Running Loop=1
2020-12-13T18:04:30.865Z,1607882670.865 [DefaultWithUndock:LeaveDock:A.](INFO): Initializing TrackAcousticContact.
2020-12-13T18:04:30.865Z,1607882670.865 [DefaultWithUndock:LeaveDock:B.Undock] Running Loop=1
2020-12-13T18:04:30.865Z,1607882670.865 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initialize.
2020-12-13T18:04:30.865Z,1607882670.865 [DefaultWithUndock:LeaveDock:B.Undock](DEBUG): Initializing internal variables to default values.
2020-12-13T18:04:31.648Z,1607882671.648 [PowerOnly](INFO): Powering up loadControl
2020-12-13T18:04:33.381Z,1607882673.381 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:34.949Z,1607882674.949 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detaching from dock.
2020-12-13T18:04:35.366Z,1607882675.366 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detected possible detachment. Starting timer.
2020-12-13T18:04:36.146Z,1607882676.146 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:37.888Z,1607882677.888 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T18:04:38.961Z,1607882678.961 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:41.806Z,1607882681.806 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:44.627Z,1607882684.627 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:47.502Z,1607882687.502 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:50.320Z,1607882690.320 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:53.150Z,1607882693.150 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:55.572Z,1607882695.572 [DefaultWithUndock:LeaveDock:B.Undock](INFO): Detached at range: 523.38 m. Transitioning DDM to standby.
2020-12-13T18:04:55.941Z,1607882695.941 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:58.797Z,1607882698.797 [DefaultWithUndock:LeaveDock:B.Undock](INFO): DDM at standby.
2020-12-13T18:04:58.798Z,1607882698.798 [DefaultWithUndock:LeaveDock:A.](INFO): *** querying acoustic contact ***
2020-12-13T18:04:59.209Z,1607882699.209 [DefaultWithUndock:LeaveDock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-12-13T18:04:59.209Z,1607882699.209 [DefaultWithUndock:LeaveDock:B.Undock] Stopped
2020-12-13T18:04:59.210Z,1607882699.210 [DefaultWithUndock:LeaveDock](INFO): Completed DefaultWithUndock:LeaveDock
2020-12-13T18:04:59.210Z,1607882699.210 [DefaultWithUndock:LeaveDock] Stopped
2020-12-13T18:04:59.210Z,1607882699.210 [DefaultWithUndock:LeaveDock](DEBUG): Aggregate::uninitialize DefaultWithUndock:LeaveDock
2020-12-13T18:04:59.210Z,1607882699.210 [DefaultWithUndock:LeaveDock:A.] Stopped
2020-12-13T18:04:59.210Z,1607882699.210 [DefaultWithUndock:SurfaceDefault] Running Loop=1
2020-12-13T18:04:59.210Z,1607882699.210 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault
2020-12-13T18:04:59.210Z,1607882699.210 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Running Loop=1
2020-12-13T18:04:59.211Z,1607882699.211 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen
2020-12-13T18:04:59.211Z,1607882699.211 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Running Loop=1
2020-12-13T18:04:59.211Z,1607882699.211 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Running Loop=1
2020-12-13T18:04:59.211Z,1607882699.211 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Running Loop=1
2020-12-13T18:04:59.211Z,1607882699.211 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-12-13T18:04:59.211Z,1607882699.211 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-12-13T18:04:59.211Z,1607882699.211 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-12-13T18:04:59.212Z,1607882699.212 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-12-13T18:04:59.212Z,1607882699.212 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-12-13T18:04:59.213Z,1607882699.213 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-12-13T18:04:59.551Z,1607882699.551 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=1
2020-12-13T18:04:59.551Z,1607882699.551 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:04:59.551Z,1607882699.551 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2020-12-13T18:04:59.551Z,1607882699.551 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen] Stopped
2020-12-13T18:04:59.551Z,1607882699.551 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:HoldLatchOpen
2020-12-13T18:04:59.551Z,1607882699.551 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:A] Stopped
2020-12-13T18:04:59.551Z,1607882699.551 [DefaultWithUndock:SurfaceDefault:HoldLatchOpen:B] Stopped
2020-12-13T18:05:01.556Z,1607882701.556 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,180501.00,A,4134.18976,N,07041.66855,W,0.272,0.00,131220,,,A*7C
2020-12-13T18:05:01.558Z,1607882701.558 [NAL9602](INFO): GPS fix at 20201213T180501: (41.569829, -70.694476)
2020-12-13T18:05:01.580Z,1607882701.580 [UniversalFixResidualReporter](INFO): Fix residual: 5.1 %DT, over the last 2627.8 m. Residual distance 133.9 m at bearing -29.8 degrees. Fix at (41.5698, -70.6945) with 594.1 m made good.
2020-12-13T18:05:01.581Z,1607882701.581 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2020-12-13T18:05:01.582Z,1607882701.582 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2020-12-13T18:05:13.032Z,1607882713.032 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T18:05:19.497Z,1607882719.497 [RDI_Pathfinder](ERROR): only read -1 of 4 data items
2020-12-13T18:05:24.728Z,1607882724.728 [NAL9602](INFO): SBD MO Status=2, MOMSN=12807, MT Status=2, MTMSN=0
2020-12-13T18:05:24.728Z,1607882724.728 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-12-13T18:05:43.457Z,1607882743.457 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T18:05:48.172Z,1607882748.172 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T18:06:03.183Z,1607882763.183 [PowerOnly](INFO): Powering down loadControl
2020-12-13T18:06:14.100Z,1607882774.100 [NAL9602](INFO): SBD MO Status=2, MOMSN=12807, MT Status=2, MTMSN=0
2020-12-13T18:06:14.101Z,1607882774.101 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-12-13T18:06:23.320Z,1607882783.320 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2020-12-13T18:06:34.792Z,1607882794.792 [NAL9602](INFO): SBD MO Status=1, MOMSN=12807, MT Status=0, MTMSN=0
2020-12-13T18:06:34.840Z,1607882794.840 [NAL9602](INFO): Sent 101 bytes from file Logs/20201213T154932/Courier0018.lzma
2020-12-13T18:06:34.840Z,1607882794.840 [NAL9602](INFO): Packets left to send: 0
2020-12-13T18:06:40.526Z,1607882800.526 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-12-13T18:06:45.371Z,1607882805.371 [NAL9602](INFO): SBD MO Status=2, MOMSN=12808, MT Status=2, MTMSN=0
2020-12-13T18:06:45.372Z,1607882805.372 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-12-13T18:06:52.451Z,1607882812.451 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003218
2020-12-13T18:06:56.474Z,1607882816.474 [DataOverHttps](INFO): Sending 707 bytes from file Logs/20201213T154932/Express0019.lzma
2020-12-13T18:06:56.913Z,1607882816.913 [NAL9602](INFO): SBD MO Status=1, MOMSN=12808, MT Status=0, MTMSN=0
2020-12-13T18:06:56.962Z,1607882816.962 [NAL9602](INFO): Sent 184 bytes from file Logs/20201213T154932/Express0019.lzma
2020-12-13T18:06:56.963Z,1607882816.963 [NAL9602](INFO): Packets left to send: 3
2020-12-13T18:06:57.466Z,1607882817.466 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0019.lzma.bak
2020-12-13T18:06:57.466Z,1607882817.466 [DataOverHttps](INFO): SBD MOMSN=64684
2020-12-13T18:06:58.953Z,1607882818.953 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2020-12-13T18:06:58.953Z,1607882818.953 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2020-12-13T18:06:58.953Z,1607882818.953 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-13T18:07:27.606Z,1607882847.606 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T18:11:11.453Z,1607883071.453 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-12-13T18:11:26.146Z,1607883086.146 [CommandLine](IMPORTANT): got command failComponent
2020-12-13T18:11:26.150Z,1607883086.150 [CommandLine](IMPORTANT): Failed components:
2020-12-13T18:11:26.150Z,1607883086.150 [CommandLine](IMPORTANT): No failed Components.
2020-12-13T18:11:53.509Z,1607883113.509 [RDI_PathfinderUp](ERROR): only read 0 of 4 data items
2020-12-13T18:11:59.555Z,1607883119.555 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-13T18:11:59.555Z,1607883119.555 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2020-12-13T18:11:59.556Z,1607883119.556 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T18:11:59.556Z,1607883119.556 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2020-12-13T18:11:59.934Z,1607883119.934 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2020-12-13T18:11:59.934Z,1607883119.934 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2020-12-13T18:12:00.368Z,1607883120.368 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 7.989182 min 
2020-12-13T18:12:00.368Z,1607883120.368 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2020-12-13T18:12:00.368Z,1607883120.368 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:12:00.368Z,1607883120.368 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2020-12-13T18:12:00.368Z,1607883120.368 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:12:00.368Z,1607883120.368 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #2
2020-12-13T18:12:00.369Z,1607883120.369 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=2
2020-12-13T18:12:00.369Z,1607883120.369 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:12:00.369Z,1607883120.369 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2020-12-13T18:12:02.349Z,1607883122.349 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181201.00,A,4134.19091,N,07041.64214,W,0.408,96.79,131220,,,A*4C
2020-12-13T18:12:02.351Z,1607883122.351 [NAL9602](INFO): GPS fix at 20201213T181201: (41.569848, -70.694036)
2020-12-13T18:12:02.393Z,1607883122.393 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2020-12-13T18:12:02.393Z,1607883122.393 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2020-12-13T18:12:06.751Z,1607883126.751 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20201213T154932/Courier0021.lzma
2020-12-13T18:12:07.754Z,1607883127.754 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Courier0021.lzma.bak
2020-12-13T18:12:07.754Z,1607883127.754 [DataOverHttps](INFO): SBD MOMSN=64692
2020-12-13T18:12:16.792Z,1607883136.792 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20201213T154932/Express0022.lzma
2020-12-13T18:12:17.806Z,1607883137.806 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0022.lzma.bak
2020-12-13T18:12:17.806Z,1607883137.806 [DataOverHttps](INFO): SBD MOMSN=64695
2020-12-13T18:12:19.361Z,1607883139.361 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2020-12-13T18:12:19.361Z,1607883139.361 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2020-12-13T18:12:19.361Z,1607883139.361 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-13T18:12:29.056Z,1607883149.056 [NAL9602](INFO): SBD MO Status=2, MOMSN=12809, MT Status=2, MTMSN=0
2020-12-13T18:12:29.057Z,1607883149.057 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-12-13T18:12:46.428Z,1607883166.428 [NAL9602](INFO): SBD MO Status=2, MOMSN=12809, MT Status=2, MTMSN=0
2020-12-13T18:12:46.428Z,1607883166.428 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-12-13T18:12:57.331Z,1607883177.331 [NAL9602](INFO): SBD MO Status=0, MOMSN=12809, MT Status=0, MTMSN=0
2020-12-13T18:12:57.331Z,1607883177.331 [NAL9602](INFO): No messages in MT queue
2020-12-13T18:13:28.034Z,1607883208.034 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T18:17:19.970Z,1607883439.970 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-13T18:17:19.970Z,1607883439.970 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2020-12-13T18:17:19.970Z,1607883439.970 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T18:17:19.971Z,1607883439.971 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2020-12-13T18:17:20.396Z,1607883440.396 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2020-12-13T18:17:20.396Z,1607883440.396 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2020-12-13T18:17:20.773Z,1607883440.773 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 13.330217 min 
2020-12-13T18:17:20.773Z,1607883440.773 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2020-12-13T18:17:20.773Z,1607883440.773 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:17:20.773Z,1607883440.773 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2020-12-13T18:17:20.773Z,1607883440.773 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:17:20.773Z,1607883440.773 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #3
2020-12-13T18:17:20.774Z,1607883440.774 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=3
2020-12-13T18:17:20.774Z,1607883440.774 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:17:20.774Z,1607883440.774 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2020-12-13T18:17:22.780Z,1607883442.780 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,181722.00,A,4134.18973,N,07041.62022,W,0.389,131.09,131220,,,A*78
2020-12-13T18:17:22.782Z,1607883442.782 [NAL9602](INFO): GPS fix at 20201213T181722: (41.569829, -70.693670)
2020-12-13T18:17:22.794Z,1607883442.794 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2020-12-13T18:17:22.794Z,1607883442.794 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2020-12-13T18:17:27.126Z,1607883447.126 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20201213T154932/Courier0024.lzma
2020-12-13T18:17:28.126Z,1607883448.126 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Courier0024.lzma.bak
2020-12-13T18:17:28.126Z,1607883448.126 [DataOverHttps](INFO): SBD MOMSN=64702
2020-12-13T18:17:36.519Z,1607883456.519 [NAL9602](INFO): SBD MO Status=0, MOMSN=12810, MT Status=0, MTMSN=0
2020-12-13T18:17:36.528Z,1607883456.528 [NAL9602](INFO): No messages in MT queue
2020-12-13T18:17:37.164Z,1607883457.164 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20201213T154932/Express0025.lzma
2020-12-13T18:17:38.166Z,1607883458.166 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0025.lzma.bak
2020-12-13T18:17:38.166Z,1607883458.166 [DataOverHttps](INFO): SBD MOMSN=64705
2020-12-13T18:17:39.787Z,1607883459.787 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2020-12-13T18:17:39.787Z,1607883459.787 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2020-12-13T18:17:39.787Z,1607883459.787 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-13T18:18:07.249Z,1607883487.249 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T18:20:13.318Z,1607883613.318 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T18:20:23.424Z,1607883623.424 [RDI_PathfinderUp](ERROR): only read 2 of 4 data items
2020-12-13T18:22:23.414Z,1607883743.414 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T18:22:40.420Z,1607883760.420 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](INFO): Done Waiting.
2020-12-13T18:22:40.420Z,1607883760.420 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2020-12-13T18:22:40.420Z,1607883760.420 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T18:22:40.420Z,1607883760.420 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Running Loop=1
2020-12-13T18:22:40.797Z,1607883760.797 [DefaultWithUndock:SurfaceDefault:CheckIn:D] Stopped
2020-12-13T18:22:40.797Z,1607883760.797 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Running Loop=1
2020-12-13T18:22:41.202Z,1607883761.202 [DefaultWithUndock:SurfaceDefault:CheckIn:E](IMPORTANT): Default mission has been running for 18.670227 min 
2020-12-13T18:22:41.202Z,1607883761.202 [DefaultWithUndock:SurfaceDefault:CheckIn:E] Stopped
2020-12-13T18:22:41.202Z,1607883761.202 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Completed DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:22:41.202Z,1607883761.202 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2020-12-13T18:22:41.202Z,1607883761.202 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:22:41.202Z,1607883761.202 [DefaultWithUndock:SurfaceDefault:CheckIn](INFO): Running loop #4
2020-12-13T18:22:41.202Z,1607883761.202 [DefaultWithUndock:SurfaceDefault:CheckIn] Running Loop=4
2020-12-13T18:22:41.203Z,1607883761.203 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:22:41.203Z,1607883761.203 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Running Loop=1
2020-12-13T18:22:43.216Z,1607883763.216 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,182242.00,A,4134.19081,N,07041.59983,W,0.311,64.62,131220,,,A*4A
2020-12-13T18:22:43.218Z,1607883763.218 [NAL9602](INFO): GPS fix at 20201213T182242: (41.569847, -70.693331)
2020-12-13T18:22:43.284Z,1607883763.284 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_GPS] Stopped
2020-12-13T18:22:43.284Z,1607883763.284 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Running Loop=1
2020-12-13T18:22:47.460Z,1607883767.460 [DataOverHttps](INFO): Sending 75 bytes from file Logs/20201213T154932/Courier0027.lzma
2020-12-13T18:22:48.462Z,1607883768.462 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Courier0027.lzma.bak
2020-12-13T18:22:48.462Z,1607883768.462 [DataOverHttps](INFO): SBD MOMSN=64709
2020-12-13T18:22:48.479Z,1607883768.479 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-12-13T18:22:54.935Z,1607883774.935 [NAL9602](INFO): SBD MO Status=0, MOMSN=12811, MT Status=0, MTMSN=0
2020-12-13T18:22:54.952Z,1607883774.952 [NAL9602](INFO): No messages in MT queue
2020-12-13T18:22:57.502Z,1607883777.502 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20201213T154932/Express0028.lzma
2020-12-13T18:22:58.502Z,1607883778.502 [DataOverHttps](INFO): Moved sent file to Logs/20201213T154932/Express0028.lzma.bak
2020-12-13T18:22:58.502Z,1607883778.502 [DataOverHttps](INFO): SBD MOMSN=64712
2020-12-13T18:22:59.781Z,1607883779.781 [DefaultWithUndock:SurfaceDefault:CheckIn:Read_Iridium] Stopped
2020-12-13T18:22:59.781Z,1607883779.781 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Running Loop=1
2020-12-13T18:22:59.781Z,1607883779.781 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-12-13T18:23:25.630Z,1607883805.630 [NAL9602](INFO): Not Powering down - fast GPS
2020-12-13T18:26:58.582Z,1607884018.582 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2020-12-13T18:27:10.553Z,1607884030.553 [DataOverHttps](IMPORTANT): SBD MTMSN=20201213T182709
2020-12-13T18:27:13.545Z,1607884033.545 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2020-12-13T18:27:14.571Z,1607884034.571 [DataOverHttps](INFO): Received command:restart sys
2020-12-13T18:27:14.612Z,1607884034.612 [CommandLine](IMPORTANT): got command restart system
2020-12-13T18:27:16.672Z,1607884036.672 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:16.673Z,1607884036.673 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:16.744Z,1607884036.744 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-12-13T18:27:16.744Z,1607884036.744 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:16.745Z,1607884036.745 [CommandLine](INFO): Join timeout helper Thread ID is 1312
2020-12-13T18:27:16.752Z,1607884036.752 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-12-13T18:27:16.752Z,1607884036.752 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:16.753Z,1607884036.753 [NavChartDb](INFO): Join timeout helper Thread ID is 1313
2020-12-13T18:27:16.928Z,1607884036.928 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:16.928Z,1607884036.928 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:16.939Z,1607884036.939 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2020-12-13T18:27:16.939Z,1607884036.939 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:16.939Z,1607884036.939 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1314
2020-12-13T18:27:16.976Z,1607884036.976 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:16.976Z,1607884036.976 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-12-13T18:27:16.977Z,1607884036.977 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:16.980Z,1607884036.980 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2020-12-13T18:27:16.980Z,1607884036.980 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:16.980Z,1607884036.980 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1315
2020-12-13T18:27:17.660Z,1607884037.660 [CTD_Seabird](INFO): Powering down
2020-12-13T18:27:17.672Z,1607884037.672 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:17.672Z,1607884037.672 [CTD_Seabird](INFO): Powering down
2020-12-13T18:27:17.684Z,1607884037.684 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:17.692Z,1607884037.692 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-12-13T18:27:17.692Z,1607884037.692 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:17.692Z,1607884037.692 [Radio_Surface](INFO): Join timeout helper Thread ID is 1316
2020-12-13T18:27:17.780Z,1607884037.780 [Radio_Surface](INFO): Powering down
2020-12-13T18:27:17.781Z,1607884037.781 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:17.781Z,1607884037.781 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:17.793Z,1607884037.793 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2020-12-13T18:27:17.793Z,1607884037.793 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:17.793Z,1607884037.793 [Onboard](INFO): Join timeout helper Thread ID is 1317
2020-12-13T18:27:18.452Z,1607884038.452 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:18.452Z,1607884038.452 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:18.457Z,1607884038.457 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-12-13T18:27:18.457Z,1607884038.457 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:18.457Z,1607884038.457 [DataOverHttps](INFO): Join timeout helper Thread ID is 1318
2020-12-13T18:27:18.584Z,1607884038.584 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:18.584Z,1607884038.584 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:18.597Z,1607884038.597 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-12-13T18:27:18.597Z,1607884038.597 [logger ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:18.597Z,1607884038.597 [logger](INFO): Join timeout helper Thread ID is 1319
2020-12-13T18:27:18.604Z,1607884038.604 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:18.604Z,1607884038.604 [logger ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:18.618Z,1607884038.618 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-12-13T18:27:18.619Z,1607884038.619 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:18.619Z,1607884038.619 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-12-13T18:27:18.619Z,1607884038.619 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:18.619Z,1607884038.619 [controlThread](INFO): Join timeout helper Thread ID is 1320
2020-12-13T18:27:18.740Z,1607884038.740 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-12-13T18:27:18.740Z,1607884038.740 [controlThread](DEBUG): Uninitializing ControlThread
2020-12-13T18:27:18.741Z,1607884038.741 [AHRS_M2](INFO): Powering down
2020-12-13T18:27:18.812Z,1607884038.812 [DDM](INFO): Powering down
2020-12-13T18:27:18.885Z,1607884038.885 [DUSBL_Hydroid](INFO): Powering down
2020-12-13T18:27:18.956Z,1607884038.956 [Micromodem](INFO): Powering down
2020-12-13T18:27:19.052Z,1607884039.052 [NAL9602](INFO): Powering down
2020-12-13T18:27:19.124Z,1607884039.124 [RDI_Pathfinder](INFO): Powering down
2020-12-13T18:27:19.196Z,1607884039.196 [RDI_PathfinderUp](INFO): Powering down
2020-12-13T18:27:19.197Z,1607884039.197 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-12-13T18:27:19.198Z,1607884039.198 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-12-13T18:27:19.199Z,1607884039.199 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-12-13T18:27:19.199Z,1607884039.199 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock] Stopped
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock:SurfaceDefault] Stopped
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock:SurfaceDefault](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock:SurfaceDefault:B.GoToSurface] Stopped
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock:SurfaceDefault:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock:SurfaceDefault:CheckIn] Stopped
2020-12-13T18:27:19.200Z,1607884039.200 [DefaultWithUndock:SurfaceDefault:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:SurfaceDefault:CheckIn
2020-12-13T18:27:19.201Z,1607884039.201 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait] Stopped
2020-12-13T18:27:19.201Z,1607884039.201 [DefaultWithUndock:SurfaceDefault:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-12-13T18:27:19.208Z,1607884039.208 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-12-13T18:27:19.209Z,1607884039.209 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-12-13T18:27:19.209Z,1607884039.209 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-12-13T18:27:19.209Z,1607884039.209 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-12-13T18:27:19.209Z,1607884039.209 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-12-13T18:27:19.210Z,1607884039.210 [BuoyancyServo](INFO): Powering down
2020-12-13T18:27:19.224Z,1607884039.224 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-12-13T18:27:19.224Z,1607884039.224 [ElevatorServo](INFO): Powering down
2020-12-13T18:27:19.225Z,1607884039.225 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-12-13T18:27:19.225Z,1607884039.225 [MassServo](INFO): Powering down
2020-12-13T18:27:19.226Z,1607884039.226 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-12-13T18:27:19.226Z,1607884039.226 [RudderServo](INFO): Powering down
2020-12-13T18:27:19.227Z,1607884039.227 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-12-13T18:27:19.227Z,1607884039.227 [ThrusterServo](INFO): Powering down
2020-12-13T18:27:19.228Z,1607884039.228 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-12-13T18:27:19.228Z,1607884039.228 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-12-13T18:27:19.228Z,1607884039.228 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-12-13T18:27:19.229Z,1607884039.229 [CBIT](DEBUG): Powering off loads.
2020-12-13T18:27:19.240Z,1607884039.240 [CBIT](DEBUG): Disabling WDT.
2020-12-13T18:27:19.252Z,1607884039.252 [CBIT](DEBUG): Opening all GF detection circuits.
2020-12-13T18:27:19.253Z,1607884039.253 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:19.260Z,1607884039.260 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:19.263Z,1607884039.263 [Onboard ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:19.275Z,1607884039.275 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:19.372Z,1607884039.372 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:19.376Z,1607884039.376 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:19.445Z,1607884039.445 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-12-13T18:27:19.515Z,1607884039.515 [logger ThreadHandler](INFO): Thread cancelled.