2021-02-12T20:00:41.894Z,1613160041.894 [CommandLine](IMPORTANT): got command restart logs 2021-02-12T20:00:51.682Z,1613160051.682 [CommandLine](IMPORTANT): got command schedule clear 2021-02-12T20:00:51.682Z,1613160051.682 [CommandLine](IMPORTANT): #Cleared scheduled commands:0 2021-02-12T20:00:51.683Z,1613160051.683 [CommandLine](IMPORTANT): got command schedule resume 2021-02-12T20:00:51.683Z,1613160051.683 [CommandLine](IMPORTANT): Scheduling is resumed 2021-02-12T20:00:53.686Z,1613160053.686 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-02-12T20:01:09.635Z,1613160069.635 [NAL9602](INFO): SBD MO Status=1, MOMSN=24951, MT Status=0, MTMSN=0 2021-02-12T20:01:09.694Z,1613160069.694 [NAL9602](INFO): Sent 39 bytes from file Logs/20210212T164912/Courier0048.lzma 2021-02-12T20:01:09.695Z,1613160069.695 [NAL9602](INFO): Packets left to send: 0 2021-02-12T20:01:24.810Z,1613160084.810 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-02-12T20:01:27.065Z,1613160087.065 [NAL9602](INFO): SBD MO Status=2, MOMSN=24952, MT Status=2, MTMSN=0 2021-02-12T20:01:27.065Z,1613160087.065 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-02-12T20:01:55.942Z,1613160115.942 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-02-12T20:02:15.996Z,1613160135.996 [NAL9602](INFO): SBD MO Status=2, MOMSN=24952, MT Status=2, MTMSN=0 2021-02-12T20:02:15.996Z,1613160135.996 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-02-12T20:02:27.066Z,1613160147.066 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-02-12T20:02:54.843Z,1613160174.843 [NAL9602](INFO): SBD MO Status=1, MOMSN=24952, MT Status=0, MTMSN=0 2021-02-12T20:02:54.898Z,1613160174.898 [NAL9602](INFO): Sent 142 bytes from file Logs/20210212T164912/Express0046.lzma 2021-02-12T20:02:54.899Z,1613160174.899 [NAL9602](INFO): Packets left to send: 0 2021-02-12T20:02:58.190Z,1613160178.190 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2021-02-12T20:03:05.797Z,1613160185.797 [NAL9602](INFO): SBD MO Status=1, MOMSN=24953, MT Status=0, MTMSN=0 2021-02-12T20:03:05.850Z,1613160185.850 [NAL9602](INFO): Sent 107 bytes from file Logs/20210212T164912/Express0049.lzma 2021-02-12T20:03:05.850Z,1613160185.850 [NAL9602](INFO): Packets left to send: 0 2021-02-12T20:03:06.714Z,1613160186.714 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003158 2021-02-12T20:03:07.825Z,1613160187.825 [Default:CheckIn:Read_Iridium] Stopped 2021-02-12T20:03:07.826Z,1613160187.826 [Default:CheckIn:C.Wait] Running Loop=1 2021-02-12T20:03:07.826Z,1613160187.826 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-02-12T20:03:25.197Z,1613160205.197 [NAL9602](INFO): SBD MO Status=2, MOMSN=24954, MT Status=2, MTMSN=0 2021-02-12T20:03:25.197Z,1613160205.197 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-02-12T20:03:55.893Z,1613160235.893 [NAL9602](INFO): Not Powering down - fast GPS 2021-02-12T20:08:08.417Z,1613160488.417 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-02-12T20:08:08.417Z,1613160488.417 [Default:CheckIn:C.Wait] Stopped 2021-02-12T20:08:08.417Z,1613160488.417 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-02-12T20:08:08.417Z,1613160488.417 [Default:CheckIn:D] Running Loop=1 2021-02-12T20:08:08.824Z,1613160488.824 [Default:CheckIn:D] Stopped 2021-02-12T20:08:08.824Z,1613160488.824 [Default:CheckIn:E] Running Loop=1 2021-02-12T20:08:09.219Z,1613160489.219 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.614521 min 2021-02-12T20:08:09.219Z,1613160489.219 [Default:CheckIn:E] Stopped 2021-02-12T20:08:09.219Z,1613160489.219 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-02-12T20:08:09.219Z,1613160489.219 [Default:CheckIn] Stopped 2021-02-12T20:08:09.219Z,1613160489.219 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-02-12T20:08:09.220Z,1613160489.220 [Default:CheckIn](INFO): Running loop #3 2021-02-12T20:08:09.220Z,1613160489.220 [Default:CheckIn] Running Loop=3 2021-02-12T20:08:09.220Z,1613160489.220 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-02-12T20:08:09.220Z,1613160489.220 [Default:CheckIn:Read_GPS] Running Loop=1 2021-02-12T20:08:11.233Z,1613160491.233 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,200808.00,A,3644.61453,N,12151.48341,W,0.272,188.29,120221,,,A*7D 2021-02-12T20:08:11.236Z,1613160491.236 [NAL9602](INFO): GPS fix at 20210212T200808: (36.743575, -121.858057) 2021-02-12T20:08:11.245Z,1613160491.245 [Default:CheckIn:Read_GPS] Stopped 2021-02-12T20:08:11.245Z,1613160491.245 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-02-12T20:08:18.194Z,1613160498.194 [DataOverHttps](INFO): Sending 268 bytes from file Logs/20210212T200041/Courier0000.lzma 2021-02-12T20:08:19.196Z,1613160499.196 [DataOverHttps](INFO): Moved sent file to Logs/20210212T200041/Courier0000.lzma.bak 2021-02-12T20:08:19.196Z,1613160499.196 [DataOverHttps](INFO): SBD MOMSN=15225788 2021-02-12T20:08:36.797Z,1613160516.797 [NAL9602](INFO): SBD MO Status=0, MOMSN=24954, MT Status=0, MTMSN=0 2021-02-12T20:08:36.797Z,1613160516.797 [NAL9602](INFO): No messages in MT queue 2021-02-12T20:08:40.579Z,1613160520.579 [DataOverHttps](INFO): Sending 457 bytes from file Logs/20210212T200041/Express0001.lzma 2021-02-12T20:08:41.580Z,1613160521.580 [DataOverHttps](INFO): Moved sent file to Logs/20210212T200041/Express0001.lzma.bak 2021-02-12T20:08:41.580Z,1613160521.580 [DataOverHttps](INFO): SBD MOMSN=15225792 2021-02-12T20:08:42.908Z,1613160522.908 [Default:CheckIn:Read_Iridium] Stopped 2021-02-12T20:08:42.908Z,1613160522.908 [Default:CheckIn:C.Wait] Running Loop=1 2021-02-12T20:08:42.908Z,1613160522.908 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-02-12T20:09:07.516Z,1613160547.516 [NAL9602](INFO): Not Powering down - fast GPS 2021-02-12T20:13:43.510Z,1613160823.510 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-02-12T20:13:43.510Z,1613160823.510 [Default:CheckIn:C.Wait] Stopped 2021-02-12T20:13:43.510Z,1613160823.510 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-02-12T20:13:43.511Z,1613160823.511 [Default:CheckIn:D] Running Loop=1 2021-02-12T20:13:43.917Z,1613160823.917 [Default:CheckIn:D] Stopped 2021-02-12T20:13:43.917Z,1613160823.917 [Default:CheckIn:E] Running Loop=1 2021-02-12T20:13:44.328Z,1613160824.328 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 19.199400 min 2021-02-12T20:13:44.328Z,1613160824.328 [Default:CheckIn:E] Stopped 2021-02-12T20:13:44.328Z,1613160824.328 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-02-12T20:13:44.328Z,1613160824.328 [Default:CheckIn] Stopped 2021-02-12T20:13:44.329Z,1613160824.329 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-02-12T20:13:44.329Z,1613160824.329 [Default:CheckIn](INFO): Running loop #4 2021-02-12T20:13:44.329Z,1613160824.329 [Default:CheckIn] Running Loop=4 2021-02-12T20:13:44.329Z,1613160824.329 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-02-12T20:13:44.329Z,1613160824.329 [Default:CheckIn:Read_GPS] Running Loop=1 2021-02-12T20:13:46.329Z,1613160826.329 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,201343.00,A,3644.59687,N,12151.52856,W,0.272,228.70,120221,,,A*7B 2021-02-12T20:13:46.331Z,1613160826.331 [NAL9602](INFO): GPS fix at 20210212T201343: (36.743281, -121.858809) 2021-02-12T20:13:46.342Z,1613160826.342 [Default:CheckIn:Read_GPS] Stopped 2021-02-12T20:13:46.342Z,1613160826.342 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-02-12T20:13:53.985Z,1613160833.985 [DataOverHttps](INFO): Sending 74 bytes from file Logs/20210212T200041/Courier0003.lzma 2021-02-12T20:13:54.988Z,1613160834.988 [DataOverHttps](INFO): Moved sent file to Logs/20210212T200041/Courier0003.lzma.bak 2021-02-12T20:13:54.988Z,1613160834.988 [DataOverHttps](INFO): SBD MOMSN=15225801 2021-02-12T20:14:03.301Z,1613160843.301 [NAL9602](INFO): SBD MO Status=0, MOMSN=24955, MT Status=0, MTMSN=0 2021-02-12T20:14:03.301Z,1613160843.301 [NAL9602](INFO): No messages in MT queue 2021-02-12T20:14:03.352Z,1613160843.352 [DataOverHttps](IMPORTANT): SBD MTMSN=20210212T201400 2021-02-12T20:14:11.047Z,1613160851.047 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20210212T200041/Express0004.lzma 2021-02-12T20:14:11.050Z,1613160851.050 [DataOverHttps](INFO): Received command:sched asap "load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 1 hour;set sci2_flat_and_level.NeedCommsTime 30 minute;set sci2_flat_and_level.Depth 30 meter;set sci2_flat_and_level.Lat1 36.797 degree" 3n6va 1 3 2021-02-12T20:14:11.068Z,1613160851.068 [CommandLine](IMPORTANT): got command schedule asap "load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 1 hour;set sci2_flat_and_level.NeedCommsTime 30 minute;set sci2_flat_and_level.Depth 30 meter;set sci2_flat_and_level.Lat1 36.797 degree" 3n6va 1 3.000000 2021-02-12T20:14:11.068Z,1613160851.068 [CommandLine](IMPORTANT): Scheduling command #1 of 3 with id=3n6va 2021-02-12T20:14:11.069Z,1613160851.069 [CommandLine](IMPORTANT): Scheduled #17 (#1 of 3 with id='3n6va'): "load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 1 hour;set sci2_flat_and_level.NeedCommsTime 30 minute;set sci2_flat_and_level.Depth 30 meter;set sci2_flat_and_level.Lat1 36.797 degree" ASAP 2021-02-12T20:14:12.302Z,1613160852.302 [DataOverHttps](INFO): Moved sent file to Logs/20210212T200041/Express0004.lzma.bak 2021-02-12T20:14:12.303Z,1613160852.303 [DataOverHttps](IMPORTANT): SBD MOMSN=15225805, MTMSN=20210212T201409 2021-02-12T20:14:19.415Z,1613160859.415 [DataOverHttps](INFO): Received command:sched asap "set sci2_flat_and_level.Lon1 -121.847 degree;set sci2_flat_and_level.Speed 0.5 meter_per_second;set sci2_flat_and_level.ApproachDepth 25 meter;set sci2_flat_and_level.ApproachSpeed 0.8 meter_per_second" 3n6va 2 3 2021-02-12T20:14:19.515Z,1613160859.515 [CommandLine](IMPORTANT): got command schedule asap "set sci2_flat_and_level.Lon1 -121.847 degree;set sci2_flat_and_level.Speed 0.5 meter_per_second;set sci2_flat_and_level.ApproachDepth 25 meter;set sci2_flat_and_level.ApproachSpeed 0.8 meter_per_second" 3n6va 2 3.000000 2021-02-12T20:14:19.515Z,1613160859.515 [CommandLine](IMPORTANT): Scheduling command #2 of 3 with id=3n6va 2021-02-12T20:14:19.516Z,1613160859.516 [CommandLine](IMPORTANT): Scheduled #18 (#2 of 3 with id='3n6va'): "set sci2_flat_and_level.Lon1 -121.847 degree;set sci2_flat_and_level.Speed 0.5 meter_per_second;set sci2_flat_and_level.ApproachDepth 25 meter;set sci2_flat_and_level.ApproachSpeed 0.8 meter_per_second" ASAP 2021-02-12T20:14:20.917Z,1613160860.917 [DataOverHttps](IMPORTANT): SBD MTMSN=20210212T201417 2021-02-12T20:14:30.594Z,1613160870.594 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210212T200041/Courier0006.lzma 2021-02-12T20:14:30.598Z,1613160870.598 [DataOverHttps](INFO): Received command:sched asap "set sci2_flat_and_level.ApproachDepthRate 0.1 meter_per_second;set sci2_flat_and_level.ApproachDepthTimeout 20 minute;set sci2_flat_and_level.MaxDepth 45 meter;run" 3n6va 3 3 2021-02-12T20:14:30.643Z,1613160870.643 [CommandLine](IMPORTANT): got command schedule asap "set sci2_flat_and_level.ApproachDepthRate 0.1 meter_per_second;set sci2_flat_and_level.ApproachDepthTimeout 20 minute;set sci2_flat_and_level.MaxDepth 45 meter;run" 3n6va 3 3.000000 2021-02-12T20:14:30.644Z,1613160870.644 [CommandLine](IMPORTANT): Scheduling command #3 of 3 with id=3n6va 2021-02-12T20:14:30.645Z,1613160870.645 [CommandLine](IMPORTANT): Scheduled #19 (#3 of 3 with id='3n6va'): "set sci2_flat_and_level.ApproachDepthRate 0.1 meter_per_second;set sci2_flat_and_level.ApproachDepthTimeout 20 minute;set sci2_flat_and_level.MaxDepth 45 meter;run" ASAP 2021-02-12T20:14:30.724Z,1613160870.724 [CommandLine](IMPORTANT): got command load ./Missions/Science/sci2_flat_and_level.xml 2021-02-12T20:14:30.725Z,1613160870.725 [MissionManager](INFO): Loading Mission: ./Missions/Science/sci2_flat_and_level.xml 2021-02-12T20:14:31.065Z,1613160871.065 [MissionManager](INFO): DefineArg sci2_flat_and_level.MissionTimeout = 2.000000 h 2021-02-12T20:14:31.068Z,1613160871.068 [MissionManager](INFO): DefineArg sci2_flat_and_level.NeedCommsTime = 60.000000 min 2021-02-12T20:14:31.075Z,1613160871.075 [MissionManager](INFO): DefineArg sci2_flat_and_level.Depth = 3.000000 m 2021-02-12T20:14:31.079Z,1613160871.079 [MissionManager](INFO): DefineArg sci2_flat_and_level.Repeat = 1.000000 count 2021-02-12T20:14:31.082Z,1613160871.082 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat1 = nan arcdeg 2021-02-12T20:14:31.085Z,1613160871.085 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon1 = nan arcdeg 2021-02-12T20:14:31.088Z,1613160871.088 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat2 = nan arcdeg 2021-02-12T20:14:31.101Z,1613160871.101 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon2 = nan arcdeg 2021-02-12T20:14:31.104Z,1613160871.104 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat3 = nan arcdeg 2021-02-12T20:14:31.107Z,1613160871.107 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon3 = nan arcdeg 2021-02-12T20:14:31.110Z,1613160871.110 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat4 = nan arcdeg 2021-02-12T20:14:31.173Z,1613160871.173 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon4 = nan arcdeg 2021-02-12T20:14:31.176Z,1613160871.176 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat5 = nan arcdeg 2021-02-12T20:14:31.184Z,1613160871.184 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon5 = nan arcdeg 2021-02-12T20:14:31.187Z,1613160871.187 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat6 = nan arcdeg 2021-02-12T20:14:31.250Z,1613160871.250 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon6 = nan arcdeg 2021-02-12T20:14:31.253Z,1613160871.253 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lat7 = nan arcdeg 2021-02-12T20:14:31.269Z,1613160871.269 [MissionManager](INFO): DefineArg sci2_flat_and_level.Lon7 = nan arcdeg 2021-02-12T20:14:31.289Z,1613160871.289 [MissionManager](INFO): DefineArg sci2_flat_and_level.Speed = 1.000000 m/s 2021-02-12T20:14:31.301Z,1613160871.301 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepth = 2.000000 m 2021-02-12T20:14:31.316Z,1613160871.316 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSpeed = 0.700000 m/s 2021-02-12T20:14:31.324Z,1613160871.324 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepthRate = 0.050000 m/s 2021-02-12T20:14:31.329Z,1613160871.329 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachPitchLimit = 20.000000 arcdeg 2021-02-12T20:14:31.349Z,1613160871.349 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachDepthTimeout = 15.000000 min 2021-02-12T20:14:31.352Z,1613160871.352 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSettleTimePreDive = 1.000000 min 2021-02-12T20:14:31.372Z,1613160871.372 [MissionManager](INFO): DefineArg sci2_flat_and_level.ApproachSettleTimePostDive = 3.000000 min 2021-02-12T20:14:31.376Z,1613160871.376 [MissionManager](INFO): DefineArg sci2_flat_and_level.kpDepth = 0.070000 rad/m 2021-02-12T20:14:31.400Z,1613160871.400 [MissionManager](INFO): DefineArg sci2_flat_and_level.BuoyancyNeutral = 316.916907 cc 2021-02-12T20:14:31.410Z,1613160871.410 [MissionManager](INFO): DefineArg sci2_flat_and_level.MassDefault = -0.943371 cm 2021-02-12T20:14:31.413Z,1613160871.413 [MissionManager](INFO): DefineArg sci2_flat_and_level.MinAltitude = 2.000000 m 2021-02-12T20:14:31.432Z,1613160871.432 [MissionManager](INFO): DefineArg sci2_flat_and_level.MaxDepth = 15.000000 m 2021-02-12T20:14:31.436Z,1613160871.436 [MissionManager](INFO): DefineArg sci2_flat_and_level.MinOffshore = 2.000000 km 2021-02-12T20:14:31.467Z,1613160871.467 [MissionManager](INFO): DefineOutput sci2_flat_and_level.DiveMode = 0.000000 count 2021-02-12T20:14:31.479Z,1613160871.479 [MissionManager](INFO): DefineOutput sci2_flat_and_level.DoingComms = 0.000000 count 2021-02-12T20:14:31.484Z,1613160871.484 [MissionManager](INFO): DefineOutput sci2_flat_and_level.InitialDive = 1.000000 count 2021-02-12T20:14:31.502Z,1613160871.502 [MissionManager](INFO): DefineOutput sci2_flat_and_level.SettleAtDepth = 2.000000 count 2021-02-12T20:14:31.515Z,1613160871.515 [MissionManager](INFO): DefineOutput sci2_flat_and_level.MaintainDepth = 3.000000 count 2021-02-12T20:14:31.515Z,1613160871.515 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml 2021-02-12T20:14:32.300Z,1613160872.300 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectChlActive = 0 bool 2021-02-12T20:14:32.303Z,1613160872.303 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.TimeWindowPeakReport = nan min 2021-02-12T20:14:32.334Z,1613160872.334 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.HighestChlPeakReportActive = 0 bool 2021-02-12T20:14:32.337Z,1613160872.337 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PatchTracking = 0 bool 2021-02-12T20:14:32.340Z,1613160872.340 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.FilterWidthHorizontal = 3.000000 count 2021-02-12T20:14:32.368Z,1613160872.368 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.NumProfilesSlidingwindow = 100.000000 count 2021-02-12T20:14:32.371Z,1613160872.371 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.OffPeakFractionHorizontal = 80.000000 % 2021-02-12T20:14:32.373Z,1613160872.373 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectNO3Active = 0 bool 2021-02-12T20:14:32.408Z,1613160872.408 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectOilActive = 0 bool 2021-02-12T20:14:32.427Z,1613160872.427 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDetectFDOMActive = 0 bool 2021-02-12T20:14:32.430Z,1613160872.430 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.UpwardDerivativeOfTemperatureActive = 0 bool 2021-02-12T20:14:32.490Z,1613160872.490 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledAanderaaO2 = 0.000000 bool 2021-02-12T20:14:32.514Z,1613160872.514 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledNeilBrown = 0.000000 bool 2021-02-12T20:14:32.538Z,1613160872.538 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledSeabird = 1.000000 bool 2021-02-12T20:14:32.574Z,1613160872.574 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsBB2FL = 1.000000 bool 2021-02-12T20:14:32.596Z,1613160872.596 [DataOverHttps](INFO): Moved sent file to Logs/20210212T200041/Courier0006.lzma.bak 2021-02-12T20:14:32.596Z,1613160872.596 [DataOverHttps](INFO): SBD MOMSN=15225810 2021-02-12T20:14:32.599Z,1613160872.599 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool 2021-02-12T20:14:32.623Z,1613160872.623 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.EnabledWetLabsUBAT = 0.000000 bool 2021-02-12T20:14:32.642Z,1613160872.642 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.LowPassWindowLength = 20.000000 count 2021-02-12T20:14:32.646Z,1613160872.646 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.MedianFilterLen = 5.000000 count 2021-02-12T20:14:32.661Z,1613160872.661 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakShallowBound = nan m 2021-02-12T20:14:32.681Z,1613160872.681 [MissionManager](INFO): DefineArg sci2_flat_and_level:Science.PeakDeepBound = nan m 2021-02-12T20:14:32.698Z,1613160872.698 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChl = 0.000000 ug/l 2021-02-12T20:14:32.717Z,1613160872.717 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlDepth = 0.000000 m 2021-02-12T20:14:32.721Z,1613160872.721 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlTemperature = 0.000000 degC 2021-02-12T20:14:32.752Z,1613160872.752 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlLatitude = nan arcdeg 2021-02-12T20:14:32.755Z,1613160872.755 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakChlLongitude = nan arcdeg 2021-02-12T20:14:32.787Z,1613160872.787 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3 = 0.000000 umol/l 2021-02-12T20:14:32.790Z,1613160872.790 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Depth = 0.000000 m 2021-02-12T20:14:32.793Z,1613160872.793 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Latitude = nan arcdeg 2021-02-12T20:14:32.825Z,1613160872.825 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakNO3Longitude = nan arcdeg 2021-02-12T20:14:32.837Z,1613160872.837 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChl = 0.000000 m 2021-02-12T20:14:32.889Z,1613160872.889 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlDepth = 0.000000 m 2021-02-12T20:14:32.901Z,1613160872.901 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlLatitude = nan arcdeg 2021-02-12T20:14:32.913Z,1613160872.913 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlLongitude = nan arcdeg 2021-02-12T20:14:32.944Z,1613160872.944 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchChlDistance = nan m 2021-02-12T20:14:32.956Z,1613160872.956 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOil = 0.000000 kg/m3 2021-02-12T20:14:32.969Z,1613160872.969 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilDepth = 0.000000 m 2021-02-12T20:14:32.981Z,1613160872.981 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilLatitude = nan arcdeg 2021-02-12T20:14:32.993Z,1613160872.993 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakOilLongitude = nan arcdeg 2021-02-12T20:14:33.005Z,1613160873.005 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOM = 0.000000 ppb 2021-02-12T20:14:33.027Z,1613160873.027 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMDepth = 0.000000 m 2021-02-12T20:14:33.040Z,1613160873.040 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMLatitude = nan arcdeg 2021-02-12T20:14:33.053Z,1613160873.053 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PeakFDOMLongitude = nan arcdeg 2021-02-12T20:14:33.058Z,1613160873.058 [MissionManager](INFO): DefineOutput sci2_flat_and_level:Science.PatchFDOMDistance = nan m 2021-02-12T20:14:33.139Z,1613160873.139 [sci2_flat_and_level:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-02-12T20:14:33.176Z,1613160873.176 [sci2_flat_and_level:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2021-02-12T20:14:33.205Z,1613160873.205 [sci2_flat_and_level:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-02-12T20:14:33.249Z,1613160873.249 [sci2_flat_and_level:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-02-12T20:14:33.328Z,1613160873.328 [sci2_flat_and_level:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2021-02-12T20:14:33.346Z,1613160873.346 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml 2021-02-12T20:14:33.421Z,1613160873.421 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MinAltitude = 5.000000 m 2021-02-12T20:14:33.440Z,1613160873.440 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MaxDepth = 200.000000 m 2021-02-12T20:14:33.449Z,1613160873.449 [MissionManager](INFO): DefineArg sci2_flat_and_level:StandardEnvelopes.MinOffshore = 2000.000000 m 2021-02-12T20:14:33.450Z,1613160873.450 [sci2_flat_and_level:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope. 2021-02-12T20:14:33.478Z,1613160873.478 [sci2_flat_and_level:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope. 2021-02-12T20:14:33.504Z,1613160873.504 [sci2_flat_and_level:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope. 2021-02-12T20:14:33.550Z,1613160873.550 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml 2021-02-12T20:14:33.747Z,1613160873.747 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.DiveInterval = 3.000000 h 2021-02-12T20:14:33.753Z,1613160873.753 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.WaitForPitchUp = 10.000000 min 2021-02-12T20:14:33.770Z,1613160873.770 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfacePitch = 20.000000 arcdeg 2021-02-12T20:14:33.773Z,1613160873.773 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfaceDepthRate = nan m/s 2021-02-12T20:14:33.785Z,1613160873.785 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.SurfaceSpeed = 1.000000 m/s 2021-02-12T20:14:33.797Z,1613160873.797 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.GPSTimeout = 7.000000 min 2021-02-12T20:14:33.809Z,1613160873.809 [MissionManager](INFO): DefineArg sci2_flat_and_level:NeedComms.CommsTimeout = 30.000000 min 2021-02-12T20:14:33.832Z,1613160873.832 [sci2_flat_and_level:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-02-12T20:14:33.967Z,1613160873.967 [sci2_flat_and_level:DiveCmd:InitialDive:dive:C.Mass](DEBUG): Construct. 2021-02-12T20:14:33.970Z,1613160873.970 [sci2_flat_and_level:DiveCmd:InitialDive:dive:D.Buoyancy](DEBUG): Construct Buoyancy. 2021-02-12T20:14:33.999Z,1613160873.999 [sci2_flat_and_level:DiveCmd:InitialDive:dive:F.Wait](DEBUG): Construct Wait. 2021-02-12T20:14:34.011Z,1613160874.011 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:A.SetSpeed](DEBUG): Construct. 2021-02-12T20:14:34.015Z,1613160874.015 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch](DEBUG): Construct. 2021-02-12T20:14:34.039Z,1613160874.039 [sci2_flat_and_level:DiveCmd:InitialDive:dive:ApproachDepth:B.Pitch:A_Timeout:B.Execute](DEBUG): Construct Execute. 2021-02-12T20:14:34.111Z,1613160874.111 [NAL9602](INFO): Not Powering down - fast GPS 2021-02-12T20:14:34.125Z,1613160874.125 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:B.Pitch](DEBUG): Construct. 2021-02-12T20:14:34.167Z,1613160874.167 [sci2_flat_and_level:DiveCmd:SettleAtDepth:dive:C.Wait](DEBUG): Construct Wait. 2021-02-12T20:14:34.197Z,1613160874.197 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:ThrusterDive:A.Mass](DEBUG): Construct. 2021-02-12T20:14:34.205Z,1613160874.205 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:ThrusterDive:B.Buoyancy](DEBUG): Construct Buoyancy. 2021-02-12T20:14:34.220Z,1613160874.220 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:B.SetSpeed](DEBUG): Construct. 2021-02-12T20:14:34.243Z,1613160874.243 [sci2_flat_and_level:DiveCmd:MaintainDepth:dive:C.Pitch](DEBUG): Construct. 2021-02-12T20:14:34.291Z,1613160874.291 [sci2_flat_and_level:Lap:Wpt1:A.Waypoint](DEBUG): Construct Waypoint. 2021-02-12T20:14:34.315Z,1613160874.315 [sci2_flat_and_level:Lap:Wpt2:A.Waypoint](DEBUG): Construct Waypoint. 2021-02-12T20:14:34.339Z,1613160874.339 [sci2_flat_and_level:Lap:Wpt3:A.Waypoint](DEBUG): Construct Waypoint. 2021-02-12T20:14:34.361Z,1613160874.361 [sci2_flat_and_level:Lap:Wpt4:A.Waypoint](DEBUG): Construct Waypoint. 2021-02-12T20:14:34.380Z,1613160874.380 [sci2_flat_and_level:Lap:Wpt5:A.Waypoint](DEBUG): Construct Waypoint. 2021-02-12T20:14:34.412Z,1613160874.412 [sci2_flat_and_level:Lap:Wpt6:A.Waypoint](DEBUG): Construct Waypoint. 2021-02-12T20:14:34.455Z,1613160874.455 [sci2_flat_and_level:Lap:Wpt7:A.Waypoint](DEBUG): Construct Waypoint. 2021-02-12T20:14:34.597Z,1613160874.597 [MissionManager](DEBUG): Vehicle transits to the specified waypoints at the commanded depth (flat-and-level) with science turned on. Maximum duration of mission 2 How often to surface for commumications 60 Depth of flat and level flight during the mission. 3 Number of times the vehicle should try to cycle through waypoints. 1 Latitude of waypoint 1. If nan, waypoint is skipped. NaN Longitude of waypoint 1. If nan, waypoint is skipped. NaN Latitude of waypoint 2. If nan, waypoint is skipped. NaN Longitude of waypoint 2. If nan, waypoint is skipped. NaN Latitude of waypoint 3. If nan, waypoint is skipped. NaN Longitude of waypoint 3. If nan, waypoint is skipped. NaN Latitude of waypoint 4. If nan, waypoint is skipped. NaN Longitude of waypoint 4. If nan, waypoint is skipped. NaN Latitude of waypoint 5. If nan, waypoint is skipped. NaN Longitude of waypoint 5. If nan, waypoint is skipped. NaN Latitude of waypoint 6. If nan, waypoint is skipped. NaN Longitude of waypoint 6. If nan, waypoint is skipped. NaN Latitude of waypoint 7. If nan, waypoint is skipped. NaN Longitude of waypoint 7. If nan, waypoint is skipped. NaN Speed while transiting to waypoints. 1 Depth for initial descent form the surface. 2 Speed while descending to target depth. 0.7 Descent depth rate (Positive depth rate means going down). 0.05 Max vehicle pitch (+/-) when decending from the surface. 20 Maximum time duration for the vehicle to reach the target depth 15 Time duration for the vehicle to pump down the VBS *BEFORE* leaving the surface. 1 Time duration for the vehicle to settle *AFTER* reaching the target depth. 3 Dive loop proportional gain (applied only while the vehicle is descending to target depth). 0.07 Buoyancy bladder position during the mission. Defaults to buoyancyNeutral setting in the Config/Control.cfg file. Set to NaN cc for active buoyancy. Static setting for mass during the mission. Set to NaN mm for active mass position. Minimum height above the sea floor for the entire mission. 2 Maximum depth for the entire mission. 15 Minimum offshore distance for the entire mission. 2 Mission variable (don't change). The mission sets this variable to switch between dive modes. Initialized to DoingComms. 0 Mission variable (don't change). The mission will run in this to mode when doing surface comms. 0 Mission variable (don't change). The mission will run in this mode after surface comms are done to dive the vehicle to the approach depth. 1 Mission variable (don't change). The mission will run in this mode to settle the vehicle at the target depth. 2 Mission variable (don't change). The mission will run in this mode to maintain the vehicle at the target depth. 3 Run the science sensors. 0 Called when the vehicle should be underwater. Arbitrates between 3 dive modes: 1) descend from the surface to initial depth. 2) settle at target depth using the VB. 3) cruise at target depth. Descend from the surface to target depth, limit pitch and depth-rate. Waiting for while pumping down to neutral. Take a few moments to ensure the VBS reaches neutral. Moving to Timed out while trying to reach target depth at current depth of stop Take a few more moments here to make sure the vechile is settled at the target depth. Reached , settling for Cruise at the target depth. 0.0 2021-02-12T20:14:34.614Z,1613160874.614 [CommandLine](IMPORTANT): Loaded ./Missions/Science/sci2_flat_and_level.xml 2021-02-12T20:14:51.804Z,1613160891.804 [DataOverHttps](IMPORTANT): SBD MTMSN=20210212T201448 2021-02-12T20:15:02.797Z,1613160902.797 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20210212T200041/Courier0009.lzma 2021-02-12T20:15:02.800Z,1613160902.800 [DataOverHttps](INFO): Received command:sched "load Science/sci2_flat_and_level.xml;set sci2_flat_and_level.MissionTimeout 1 hour;set sci2_flat_and_level.NeedCommsTime 30 minute;set sci2_flat_and_level.Depth 30 meter;set sci2_flat_and_level.Lat1 36.797 degree" 3n6w5 1 3 2021-02-12T20:15:03.666Z,1613160903.666 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.MissionTimeout 1.000000 hour 2021-02-12T20:15:03.667Z,1613160903.667 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.NeedCommsTime 30.000000 minute 2021-02-12T20:15:03.668Z,1613160903.668 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.Depth 30.000000 meter 2021-02-12T20:15:03.669Z,1613160903.669 [CommandLine](IMPORTANT): got command set sci2_flat_and_level.Lat1 36.797001 degree 2021-02-12T20:15:03.718Z,1613160903.718 [CommandLine](IMPORTANT): got command schedule 2021-02-12T20:15:03.719Z,1613160903.719 [CommandLine](FAULT): Incomplete syntax. Try: help schedule 2021-02-12T20:15:03.728Z,1613160903.728 [DataOverHttps](CRITICAL): SIGSEGV: address not mapped to object 2021-02-12T20:15:03.728Z,1613160903.728 [DataOverHttps](CRITICAL): Bad address: 0x8 2021-02-12T20:15:03.728Z,1613160903.728 [DataOverHttps](CRITICAL): Backtrace: ./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1a0644] 2021-02-12T20:15:03.728Z,1613160903.728 [DataOverHttps] Software Fault, FailCount= 1 2021-02-12T20:15:03.729Z,1613160903.729 [DataOverHttps](ERROR): Software Fault 2021-02-12T20:15:03.785Z,1613160903.785 [CommandLine](FAULT): Scheduling is paused for 2 commands 2021-02-12T20:15:03.786Z,1613160903.786 [CBIT](INFO): Critical error at 20210212T201503 2021-02-12T20:15:03.786Z,1613160903.786 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-02-12T20:15:03.788Z,1613160903.788 [CBIT](ERROR): Software Fault in component: DataOverHttps 2021-02-12T20:15:03.789Z,1613160903.789 [CBIT](FAULT): Software Fault in component: DataOverHttps 2021-02-12T20:15:04.152Z,1613160904.152 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087C4E0 2021-02-12T20:15:04.152Z,1613160904.152 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8321 2021-02-12T20:15:33.248Z,1613160933.248 [NAL9602](INFO): SBD MO Status=1, MOMSN=24956, MT Status=0, MTMSN=0 2021-02-12T20:15:33.302Z,1613160933.302 [NAL9602](INFO): Sent 39 bytes from file Logs/20210212T200041/Courier0009.lzma 2021-02-12T20:15:33.303Z,1613160933.303 [NAL9602](INFO): Packets left to send: 0 2021-02-12T20:15:51.055Z,1613160951.055 [NAL9602](INFO): SBD MO Status=2, MOMSN=24957, MT Status=2, MTMSN=0 2021-02-12T20:15:51.055Z,1613160951.055 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2021-02-12T20:16:11.701Z,1613160971.701 [NAL9602](INFO): SBD MO Status=1, MOMSN=24957, MT Status=0, MTMSN=0 2021-02-12T20:16:11.754Z,1613160971.754 [NAL9602](INFO): Sent 39 bytes from file Logs/20210212T200041/Courier0012.lzma 2021-02-12T20:16:11.754Z,1613160971.754 [NAL9602](INFO): Packets left to send: 0 2021-02-12T20:16:23.873Z,1613160983.873 [NAL9602](INFO): SBD MO Status=1, MOMSN=24958, MT Status=0, MTMSN=0 2021-02-12T20:16:23.923Z,