Running bin\geopdvc.pl at Sat Jan 7 03:01:26 2017 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3987 bin\geopdvc.pl: Getting Expedition object for diveno = 3987 and rname = vnta set_expd(): rov = vnta, diveno = 3987 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 = 3987 AND RovName = 'vnta' RS->Fields(0)->Value= 5739 RS->Fields(1)->Value= 1478726049 RS->Fields(2)->Value= 1478729505 RS->Fields(3)->Value= 11/9/2016 9:14:09 PM RS->Fields(4)->Value= 11/9/2016 10:11:45 PM set_expd(): $self->{EndDDD} = 314 set_expd(): $self->{StartEsecs} = 1478724849 set_expd(): $self->{EndEsecs} = 1478730705 set_expd(): $self->{EndDtg} = 11/9/2016 10:11:45 PM _readLogr(): Reading videologr data from 2016314datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1478724849 & 1478730705 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1478730709, self->{EndEsecs} = 1478730705 _readLogr(): #LOGHOST_SYSTEM_UTC = 584 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1478724858 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1478730699 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1478724858 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1478730699 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1478724729, Refined EndEsecs = 1478730825 _readLogr(): Reading videologr data from 2016314datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1478724729 & 1478730825 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1478730829, self->{EndEsecs} = 1478730825 _readLogr(): #LOGHOST_SYSTEM_UTC = 608 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1478724738 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1478730819 bin\geopdvc.pl: expdid = 5739 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 = 314 (looping to 314) Does file exist?: \\atlas\RovNavEdit\2016\vnta\nav2016314vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2016\vnta\nav2016314vnta.txt esecs, east, north, lat, lon, head, pres 1478726479, 0, 0, 36.748020, -122.105822, 326.1, 147.35 1478726979, 0, 0, 36.748035, -122.106040, 331.5, 325.25 1478727480, 0, 0, 36.748970, -122.106412, 352.9, 442.40 1478727981, 0, 0, 36.747492, -122.106868, 202.9, 445.08 1478728482, 0, 0, 36.747438, -122.107165, 306.8, 298.05 1478728983, 0, 0, 36.747445, -122.107048, 307.7, 138.59 1478729484, 0, 0, 36.747503, -122.107245, 339.5, 8.46 rovNav(): 314: 3449 in tList after reading from \\atlas\RovNavEdit\2016\vnta\nav2016314vnta.txt 3449 in tList 3449 in {self->{rovT}} 3449 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1478728845 & 1478727750 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): .............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 270.277382004322 rovGDCListRefs(): dStats->sample_range = 447.488300820199 rovGDCListRefs(): returning (1st elements): 1478726051 36.704535 -122.055772 11.4 2.58078299437658 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 314 (looping to 314) Does file exist?: \\atlas\RovNavEdit\2016\vnta\nav2016314vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2016\vnta\nav2016314vntaedited.txt esecs, east, north, lat, lon, head, pres 1478726479, 0, 0, 36.748004, -122.105826, 326.1, 147.35 1478726979, 0, 0, 36.748028, -122.106091, 331.5, 325.25 1478727480, 0, 0, 36.748933, -122.106450, 352.9, 442.40 1478727981, 0, 0, 36.747487, -122.106909, 202.9, 445.08 1478728482, 0, 0, 36.747425, -122.107144, 306.8, 298.05 1478728983, 0, 0, 36.747490, -122.107106, 307.7, 138.59 1478729484, 0, 0, 36.747468, -122.107314, 339.5, 8.46 rovNav(): 314: 3449 in tList after reading from \\atlas\RovNavEdit\2016\vnta\nav2016314vntaedited.txt 3449 in tList 3449 in {self->{rovT}} 3449 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1478728845 & 1478727750 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXXXX.......................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 270.277381765071 rovGDCListRefs(): dStats->sample_range = 447.488312210056 rovGDCListRefs(): returning (1st elements): 1478726051 36.747988 -122.105618 11.4 2.58077307740474 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.74791400 hash{lon} = -122.10649200 latMin = 30.747914 latMax = 42.747914 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.747914 AND 42.747914 AND Longitude BETWEEN -128.106492 AND -116.106492 Dive lat = 36.74791400, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.10649200 & latframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2016/314/accesses.txt at bin\geopdvc.pl line 2382 = 36.74791400 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3987rov_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 = geo2016/vnta/vnta3987lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 608 shipNav(): $#{$self->{shipLat}}[last] = 36.751667 Position subsampling set to 3 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 = 3450 makeTracks(): Looping through 608 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3987tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2016/vnta/vnta3987mergedCtdNav.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 '11/9/2016 9:14:09 PM' AND '11/9/2016 10:11:45 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '11/9/2016 9:14:09 PM' AND '11/9/2016 10:11:45 PM') _findIndex(): Looking for epoch secs 1478727494 ... Found time 1478727493 after 7 iterations. >>> p = 1440: annotations(): 1440, 1478727494, 11/09/16 21:38:14, V3987-01HD, 00:26:18:18, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_26_18_18.jpg, 439.209991455078, cruise, robs, u, 20065110 _findIndex(): Looking for epoch secs 1478727500 ... Found time 1478727500 after 8 iterations. >>> p = 1447: annotations(): 1447, 1478727500, 11/09/16 21:38:20, V3987-01HD, 00:26:24:03, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_26_24_03.jpg, 439.019989013672, cruise, robs, u, 20065111 _findIndex(): Looking for epoch secs 1478727519 ... Found time 1478727520 after 7 iterations. >>> p = 1467: annotations(): 1467, 1478727519, 11/09/16 21:38:39, V3987-01HD, 00:26:43:02, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_26_43_02.jpg, 438.579986572266, cruise, robs, u, 20065112 _findIndex(): Looking for epoch secs 1478727567 ... Found time 1478727562 after 3 iterations. >>> p = 1508: annotations(): 1508, 1478727567, 11/09/16 21:39:27, V3987-01HD, 00:27:31:01, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_27_31_01.jpg, 439.5, cruise, robs, u, 20065113 _findIndex(): Looking for epoch secs 1478727584 ... Found time 1478727589 after 6 iterations. >>> p = 1535: annotations(): 1535, 1478727584, 11/09/16 21:39:44, V3987-01HD, 00:27:48:15, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_27_48_15.jpg, 439.119995117188, cruise, robs, u, 20065114 _findIndex(): Looking for epoch secs 1478727594 ... Found time 1478727589 after 6 iterations. >>> p = 1535: annotations(): 1535, 1478727594, 11/09/16 21:39:54, V3987-01HD, 00:27:58:00, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_27_58_00.jpg, 438.820007324219, cruise, robs, u, 20065115 _findIndex(): Looking for epoch secs 1478727607 ... Found time 1478727602 after 7 iterations. >>> p = 1548: annotations(): 1548, 1478727607, 11/09/16 21:40:07, V3987-01HD, 00:28:11:15, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_28_11_15.jpg, 438.739990234375, cruise, robs, u, 20065116 _findIndex(): Looking for epoch secs 1478728121 ... Found time 1478728122 after 8 iterations. >>> p = 2067: annotations(): 2067, 1478728121, 11/09/16 21:48:41, V3987-01HD, 00:36:44:14, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_36_44_14.jpg, 405.75, cruise, robs, u, 20065117 _findIndex(): Looking for epoch secs 1478728124 ... Found time 1478728129 after 6 iterations. >>> p = 2074: annotations(): 2074, 1478728124, 11/09/16 21:48:44, V3987-01HD, 00:36:47:29, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_36_47_29.jpg, 405.149993896484, cruise, robs, u, 20065118 _findIndex(): Looking for epoch secs 1478728170 ... Found time 1478728169 after 7 iterations. >>> p = 2114: annotations(): 2114, 1478728170, 11/09/16 21:49:30, V3987-01HD, 00:37:33:28, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3987/00_37_33_28.jpg, 390.880004882813, cruise, robs, u, 20065119 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: Ancillary data = ["", "P: 395.9 db", "T: 6.751 C", "S: 34.152", "O: 0.867 ml/l", "L: 84.76 %"] inline_name = vnta3987anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.6 db", "T: 6.383 C", "S: 34.181", "O: 0.64 ml/l", "L: 84.9 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.7 db", "T: 6.395 C", "S: 34.18", "O: 0.644 ml/l", "L: 84.89 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.6 db", "T: 6.393 C", "S: 34.181", "O: 0.641 ml/l", "L: 84.88 %"] placeAnnotations(): Placing annotation 8: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 409.8 db", "T: 6.671 C", "S: 34.17", "O: 0.776 ml/l", "L: 84.8 %"] placeAnnotations(): Placing annotation 10: Ancillary data = ["", "P: 395.9 db", "T: 6.751 C", "S: 34.152", "O: 0.867 ml/l", "L: 84.76 %"] inline_name = vnta3987anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.6 db", "T: 6.383 C", "S: 34.181", "O: 0.64 ml/l", "L: 84.9 %"] placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.6 db", "T: 6.383 C", "S: 34.181", "O: 0.64 ml/l", "L: 84.9 %"] placeAnnotations(): Placing annotation 3: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 443.9 db", "T: 6.397 C", "S: 34.182", "O: 0.642 ml/l", "L: 84.88 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.7 db", "T: 6.395 C", "S: 34.18", "O: 0.644 ml/l", "L: 84.89 %"] placeAnnotations(): Placing annotation 5: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.6 db", "T: 6.393 C", "S: 34.181", "O: 0.6frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2016/314/accesses.txt at bin\geopdvc.pl line 625 41 ml/l", "L: 84.88 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.6 db", "T: 6.393 C", "S: 34.181", "O: 0.641 ml/l", "L: 84.88 %"] placeAnnotations(): Placing annotation 7: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.5 db", "T: 6.406 C", "S: 34.182", "O: 0.64 ml/l", "L: 84.9 %"] placeAnnotations(): Placing annotation 8: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 409.8 db", "T: 6.671 C", "S: 34.17", "O: 0.776 ml/l", "L: 84.8 %"] placeAnnotations(): Placing annotation 9: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 409.8 db", "T: 6.671 C", "S: 34.17", "O: 0.776 ml/l", "L: 84.8 %"] placeAnnotations(): Placing annotation 10: Ancillary data = ["", "P: 395.9 db", "T: 6.751 C", "S: 34.152", "O: 0.867 ml/l", "L: 84.76 %"] inline_name = vnta3987anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2016/vnta3987... frameGrabs(): matched 00_26_18_18 in