Running bin\geopdvc.pl at Sat Nov 14 03:00:04 2015 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3866 bin\geopdvc.pl: Getting Expedition object for diveno = 3866 and rname = vnta set_expd(): rov = vnta, diveno = 3866 set_expd(): Executing sql: SELECT ExpeditionID_FK, DateDiff(ss, '01/01/70', DiveStartDtg), DateDiff(ss, '01/01/70', DiveEndDtg), DiveStartDtg, DiveEndDtg FROM Dive WHERE DiveNumber = 3866 AND RovName = 'vnta' RS->Fields(0)->Value= 5346 RS->Fields(1)->Value= 1442417333 RS->Fields(2)->Value= 1442423722 RS->Fields(3)->Value= 9/16/2015 3:28:53 PM RS->Fields(4)->Value= 9/16/2015 5:15:22 PM set_expd(): $self->{EndDDD} = 259 set_expd(): $self->{StartEsecs} = 1442416133 set_expd(): $self->{EndEsecs} = 1442424922 set_expd(): $self->{EndDtg} = 9/16/2015 5:15:22 PM _readLogr(): Reading videologr data from 2015259datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1442416133 & 1442424922 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1442424929, self->{EndEsecs} = 1442424922 _readLogr(): #LOGHOST_SYSTEM_UTC = 878 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1442416138 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1442424919 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1442416138 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1442424919 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1442416013, Refined EndEsecs = 1442425042 _readLogr(): Reading videologr data from 2015259datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1442416013 & 1442425042 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1442425049, self->{EndEsecs} = 1442425042 _readLogr(): #LOGHOST_SYSTEM_UTC = 902 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1442416018 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1442425039 bin\geopdvc.pl: expdid = 5346 bin\geopdvc.pl: Calling rovNavCTDO to get raw nav data... rovnavCTDO(): calcUTM = 0 rovnavCTDO(): getRaw = 1 rovNav(): 1, calcUTM = 0 rovNav(): 2, getRaw = 1 rovNav(): calcUTM = 0 rovNav(): DDD = 259 (looping to 259) Does file exist?: \\atlas\RovNavEdit\2015\vnta\nav2015259vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2015\vnta\nav2015259vnta.txt esecs, east, north, lat, lon, head, pres 1442417831, 0, 0, 36.712643, -122.186822, 175.0, 190.71 1442418332, 0, 0, 36.712540, -122.186478, 204.8, 465.53 1442418833, 0, 0, 36.712377, -122.186395, 269.5, 692.74 1442419334, 0, 0, 36.712648, -122.186868, 278.6, 885.91 1442419835, 0, 0, 36.712568, -122.186908, 111.0, 886.87 1442420336, 0, 0, 36.712692, -122.186732, 177.8, 887.53 1442420837, 0, 0, 36.712670, -122.186742, 177.8, 887.56 1442421338, 0, 0, 36.712790, -122.186602, 166.6, 887.07 1442421838, 0, 0, 36.713353, -122.186815, 317.1, 762.81 1442422339, 0, 0, 36.713805, -122.186802, 316.9, 539.58 1442422840, 0, 0, 36.714282, -122.187075, 317.2, 303.11 1442423341, 0, 0, 36.714808, -122.187797, 315.9, 63.63 rovNav(): 259: 6371 in tList after reading from \\atlas\RovNavEdit\2015\vnta\nav2015259vnta.txt 6371 in tList 6371 in {self->{rovT}} 6371 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1442421405 & 1442422755 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 683.293377663614 rovGDCListRefs(): dStats->sample_range = 877.946270916337 rovGDCListRefs(): returning (1st elements): 1442417332 36.769840 -121.968897 81.3 2.54106421237016 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 259 (looping to 259) Does file exist?: \\atlas\RovNavEdit\2015\vnta\nav2015259vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2015\vnta\nav2015259vntaedited.txt esecs, east, north, lat, lon, head, pres 1442417831, 0, 0, 36.712667, -122.186809, 175.0, 190.71 1442418332, 0, 0, 36.712521, -122.186456, 204.8, 465.53 1442418833, 0, 0, 36.712375, -122.186381, 269.5, 692.74 1442419334, 0, 0, 36.712437, -122.186660, 278.6, 885.91 1442419835, 0, 0, 36.712520, -122.186846, 111.0, 886.87 1442420336, 0, 0, 36.712686, -122.186735, 177.8, 887.53 1442420837, 0, 0, 36.712670, -122.186729, 177.8, 887.56 1442421338, 0, 0, 36.712780, -122.186625, 166.6, 887.07 1442421838, 0, 0, 36.713305, -122.186814, 317.1, 762.81 1442422339, 0, 0, 36.713819, -122.186813, 316.9, 539.58 1442422840, 0, 0, 36.714293, -122.187094, 317.2, 303.11 1442423341, 0, 0, 36.714826, -122.187768, 315.9, 63.63 rovNav(): 259: 6371 in tList after reading from \\atlas\RovNavEdit\2015\vnta\nav2015259vntaedited.txt 6371 in tList 6371 in {self->{rovT}} 6371 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1442421405 & 1442422755 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/259/accesses.txt at bin\geopdvc.pl line 2382 ......................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 683.293377572954 rovGDCListRefs(): dStats->sample_range = 877.946270339522 rovGDCListRefs(): returning (1st elements): 1442417332 36.713150 -122.186236 81.3 2.54107695328955 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.71271200 hash{lon} = -122.18674700 latMin = 30.712712 latMax = 42.712712 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.712712 AND 42.712712 AND Longitude BETWEEN -128.186747 AND -116.186747 Dive lat = 36.71271200, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.18674700 & lat = 36.71271200 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3866rov_orig.wrl Making color lookup world... var = Light, vmin = 40, vmax = 100 val = 40, color = .8 .7 0 val = 70, color = .6 .5 0 val = 85, color = .1 .1 0 val = 100, color = 1 1 1 var = O2, vmin = 0.2, vmax = 5 val = 0.2, color = 1 1 1 val = 0.3, color = 1 1 .2 val = 0.5, color = 1 1 0 val = 0.7, color = 0 1 0 val = 5, color = 0 0 1 var = Sal, vmin = 33, vmax = 35 val = 33, color = 1 1 .1 val = 33.5, color = 1 1 0 val = 34, color = 1 0 0 val = 34.5, color = .2 1 0 val = 35, color = 0 1 0 var = Temp, vmin = 4, vmax = 15 val = 4, color = 0 0 1 val = 8, color = 1 1 0 val = 10, color = 0 1 0 val = 15, color = 1 0 0 World = geo2015/vnta/vnta3866lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 902 shipNav(): $#{$self->{shipLat}}[last] = 36.712475 Position subsampling set to 5 setROVcolorlines(): Assigning color line for Light... varColors = LightColors index0 = .8 .7 0 setROVcolorlines(): Assigning color line for O2... varColors = O2Colors index0 = 1 1 1 setROVcolorlines(): Assigning color line for Sal... varColors = SalColors index0 = 1 1 .1 setROVcolorlines(): Assigning color line for Temp... varColors = TempColors index0 = 0 0 1 makeTracks(): n = 6372 makeTracks(): Looping through 902 point of ship position data... makeTracks(): posSubsample = 5 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3866tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2015/vnta/vnta3866mergedCtdNav.txt... bin\geopdvc.pl: Annotations: annotations(): Executing sql: SELECT DISTINCT DateDiff(ss, '01/01/70', RecordedDate) AS Esecs, CONVERT(CHAR(8), RecordedDate, 1) + ' ' + SUBSTRING(CONVERT(CHAR(19), RecordedDate, 120), 12, 8) AS DateTime, VideoArchiveName AS TapeNum, TapeTimeCode, ConceptName, Image AS StillImageURL, Depth, Latitude, Longitude, CameraDirection AS Direction, ISNULL(Observer, '') AS Observer, AnnotationMode, ObservationID_FK AS ObservationID FROM dbo.Annotations WHERE (ShipName = '') AND (RecordedDate BETWEEN '9/16/2015 3:28:53 PM' AND '9/16/2015 5:15:22 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '9/16/2015 3:28:53 PM' AND '9/16/2015 5:15:22 PM') _findIndex(): Looking for epoch secs 1442419319 ... Found time 1442419318 after 9 iterations. >>> p = 1983: annotations(): 1983, 1442419319, 09/16/15 16:01:59, V3866-01HD, 00:30:58:15, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_30_58_15.jpg, , descend, lonny, u, 20058679 _findIndex(): Looking for epoch secs 1442419316 ... Found time 1442419312 after 8 iterations. >>> p = 1977: annotations(): 1977, 1442419316, 09/16/15 16:01:56, V3866-01HD, 00:30:54:29, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_30_54_29.jpg, , descend, lonny, u, 20058678 _findIndex(): Looking for epoch secs 1442419311 ... Found time 1442419312 after 8 iterations. >>> p = 1977: annotations(): 1977, 1442419311, 09/16/15 16:01:51, V3866-01HD, 00:30:50:13, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_30_50_13.jpg, , descend, lonny, u, 20058677 _findIndex(): Looking for epoch secs 1442417568 ... Found time 1442417567 after 8 iterations. >>> p = 235: annotations(): 235, 1442417568, 09/16/15 15:32:48, V3866-01HD, 00:01:47:10, water, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_01_47_10.jpg, , descend, lonny, u, 20058676 _findIndex(): Looking for epoch secs 1442419325 ... Found time 1442419325 after 3 iterations. >>> p = 1990: annotations(): 1990, 1442419325, 09/16/15 16:02:05, V3866-01HD, 00:31:04:05, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_31_04_05.jpg, , descend, lonny, u, 20058680 _findIndex(): Looking for epoch secs 1442419375 ... Found time 1442419374 after 6 iterations. >>> p = 2039: annotations(): 2039, 1442419375, 09/16/15 16:02:55, V3866-01HD, 00:31:53:21, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_31_53_21.jpg, , descend, lonny, u, 20058681 _findIndex(): Looking for epoch secs 1442419615 ... Found time 1442419610 after 8 iterations. >>> p = 2275: annotations(): 2275, 1442419615, 09/16/15 16:06:55, V3866-01HD, 00:35:54:23, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_35_54_23.jpg, , descend, lonny, u, 20058682 _findIndex(): Looking for epoch secs 1442419852 ... Found time 1442419848 after 7 iterations. >>> p = 2512: annotations(): 2512, 1442419852, 09/16/15 16:10:52, V3866-01HD, 00:39:51:11, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_39_51_11.jpg, , descend, lonny, u, 20058683 _findIndex(): Looking for epoch secs 1442420182 ... Found time 1442420183 after 8 iterations. >>> p = 2847: annotations(): 2847, 1442420182, 09/16/15 16:16:22, V3866-01HD, 00:45:22:05, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_45_22_05.jpg, , descend, lonny, u, 20058684 _findIndex(): Looking for epoch secs 1442420400 ... Found time 1442420397 after 7 iterations. >>> p = 3060: annotations(): 3060, 1442420400, 09/16/15 16:20:00, V3866-02HD, 00:48:29:16, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3866/00_48_29_16.jpg, , descend, lonny, u, 20058685 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: AframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/259/accesses.txt at bin\geopdvc.pl line 625 ncillary data = ["", "P: 887.8 db", "T: 4.135 C", "S: 34.419", "O: 0.327 ml/l", "L: 85.65 %"] inline_name = vnta3866anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 886.4 db", "T: 4.139 C", "S: 34.418", "O: 0.324 ml/l", "L: 85.92 %"] placeAnnotations(): Placing annotation 4: physical object Ancillary data = ["physical object", "P: 65.2 db", "T: 11.263 C", "S: 33.479", "O: 3.744 ml/l", "L: 86.43 %"] placeAnnotations(): Placing annotation 6: physical object Ancillary data = ["physical object", "P: 887.1 db", "T: 4.145 C", "S: 34.417", "O: 0.323 ml/l", "L: 85.91 %"] placeAnnotations(): Placing annotation 8: physical object Ancillary data = ["physical object", "P: 887.5 db", "T: 4.138 C", "S: 34.419", "O: 0.327 ml/l", "L: 85.72 %"] placeAnnotations(): Placing annotation 10: Ancillary data = ["", "P: 887.8 db", "T: 4.135 C", "S: 34.419", "O: 0.327 ml/l", "L: 85.65 %"] inline_name = vnta3866anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical object Ancillary data = ["physical object", "P: 886.5 db", "T: 4.145 C", "S: 34.417", "O: 0.323 ml/l", "L: 85.89 %"] placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 886.4 db", "T: 4.139 C", "S: 34.418", "O: 0.324 ml/l", "L: 85.92 %"] placeAnnotations(): Placing annotation 3: water Ancillary data = ["water", "P: 886.4 db", "T: 4.139 C", "S: 34.418", "O: 0.324 ml/l", "L: 85.92 %"] placeAnnotations(): Placing annotation 4: physical object Ancillary data = ["physical object", "P: 65.2 db", "T: 11.263 C", "S: 33.479", "O: 3.744 ml/l", "L: 86.43 %"] placeAnnotations(): Placing annotation 5: physical object Ancillary data = ["physical object", "P: 886.5 db", "T: 4.145 C", "S: 34.417", "O: 0.323 ml/l", "L: 85.89 %"] placeAnnotations(): Placing annotation 6: physical object Ancillary data = ["physical object", "P: 887.1 db", "T: 4.145 C", "S: 34.417", "O: 0.323 ml/l", "L: 85.91 %"] placeAnnotations(): Placing annotation 7: physical object Ancillary data = ["physical object", "P: 889 db", "T: 4.139 C", "S: 34.418", "O: 0.326 ml/l", "L: 85.79 %"] placeAnnotations(): Placing annotation 8: physical object Ancillary data = ["physical object", "P: 887.5 db", "T: 4.138 C", "S: 34.419", "O: 0.327 ml/l", "L: 85.72 %"] placeAnnotations(): Placing annotation 9: physical object Ancillary data = ["physical object", "P: 887.2 db", "T: 4.138 C", "S: 34.419", "O: 0.327 ml/l", "L: 85.59 %"] placeAnnotations(): Placing annotation 10: Ancillary data = ["", "P: 887.8 db", "T: 4.135 C", "S: 34.419", "O: 0.327 ml/l", "L: 85.65 %"] inline_name = vnta3866anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/vnta3866... frameGrabs(): matched 00_01_47_10 in