Running bin\geopdvc.pl at Sat Dec 17 03:02:02 2016 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3975 bin\geopdvc.pl: Getting Expedition object for diveno = 3975 and rname = vnta set_expd(): rov = vnta, diveno = 3975 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 = 3975 AND RovName = 'vnta' RS->Fields(0)->Value= 5714 RS->Fields(1)->Value= 1476910020 RS->Fields(2)->Value= 1476913470 RS->Fields(3)->Value= 10/19/2016 8:47:00 PM RS->Fields(4)->Value= 10/19/2016 9:44:30 PM set_expd(): $self->{EndDDD} = 293 set_expd(): $self->{StartEsecs} = 1476908820 set_expd(): $self->{EndEsecs} = 1476914670 set_expd(): $self->{EndDtg} = 10/19/2016 9:44:30 PM _readLogr(): Reading videologr data from 2016293datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1476908820 & 1476914670 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1476914679, self->{EndEsecs} = 1476914670 _readLogr(): #LOGHOST_SYSTEM_UTC = 584 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1476908828 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1476914669 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1476908828 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1476914669 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1476908700, Refined EndEsecs = 1476914790 _readLogr(): Reading videologr data from 2016293datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1476908700 & 1476914790 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1476914799, self->{EndEsecs} = 1476914790 _readLogr(): #LOGHOST_SYSTEM_UTC = 608 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1476908708 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1476914789 bin\geopdvc.pl: expdid = 5714 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 = 293 (looping to 293) Does file exist?: \\atlas\RovNavEdit\2016\vnta\nav2016293vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2016\vnta\nav2016293vnta.txt esecs, east, north, lat, lon, head, pres 1476910189, 0, 0, 36.747767, -122.107618, 344.1, 66.28 1476910690, 0, 0, 36.747903, -122.106890, 357.1, 246.06 1476911191, 0, 0, 36.748092, -122.106663, 18.1, 404.29 1476911691, 0, 0, 36.749027, -122.106362, 347.2, 443.42 1476912192, 0, 0, 36.747798, -122.107492, 234.5, 374.52 1476912693, 0, 0, 36.747803, -122.106557, 304.4, 235.65 1476913194, 0, 0, 36.747367, -122.105570, 0.4, 88.87 rovNav(): 293: 3443 in tList after reading from \\atlas\RovNavEdit\2016\vnta\nav2016293vnta.txt 3443 in tList 3443 in {self->{rovT}} 3443 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1476910920 & 1476911985 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ..............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................X rovGDCListRefs(): dMedian = 285.081850554957 rovGDCListRefs(): dStats->sample_range = 437.890851863562 rovGDCListRefs(): returning (1st elements): 1476910015 36.698720 -122.041492 310.9 2.58078432115452 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 293 (looping to 293) Does file exist?: \\atlas\RovNavEdit\2016\vnta\nav2016293vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2016\vnta\nav2016293vntaedited.txt esecs, east, north, lat, lon, head, pres 1476910189, 0, 0, 36.747745, -122.107609, 344.1, 66.28 1476910690, 0, 0, 36.747890, -122.106892, 357.1, 246.06 1476911191, 0, 0, 36.748103, -122.106686, 18.1, 404.29 1476911691, 0, 0, 36.748980, -122.106343, 347.2, 443.42 1476912192, 0, 0, 36.747778, -122.107478, 234.5, 374.52 1476912693, 0, 0, 36.747801, -122.106531, 304.4, 235.65 1476913194, 0, 0, 36.747372, -122.105561, 0.4, 88.87 rovNav(): 293: 3443 in tList after reading from \\atlas\RovNavEdit\2016\vnta\nav2016293vntaedited.txt 3443 in tList 3443 in {self->{rovT}} 3443 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1476910920 & 1476911985 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXXXX........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................X rovGDCListRefs(): dMedian = 285.081850050638 rovGDCListRefs(): dStats->sample_range = 437.890862238743 rovGDCListRefs(): returning (1st elements): 1476910015 36.747604 -122.107397 310.9 2.58077316506186 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.74782350 hash{lon} = -122.10674200 latMin = 30.7478235 latMax = 42.7478235 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.7478235 AND 42.7478235 AND Longitude BETWEEN -128.106742 AND -116.106742 Dive lat = 36.74782350, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.10674200 & lat = 36.7frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2016/293/accesses.txt at bin\geopdvc.pl line 2382 4782350 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3975rov_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/vnta3975lookup.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.750412 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 = 3444 makeTracks(): Looping through 608 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3975tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2016/vnta/vnta3975mergedCtdNav.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 '10/19/2016 8:47:00 PM' AND '10/19/2016 9:44:30 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '10/19/2016 8:47:00 PM' AND '10/19/2016 9:44:30 PM') _findIndex(): Looking for epoch secs 1476911492 ... Found time 1476911495 after 6 iterations. >>> p = 1478: annotations(): 1478, 1476911492, 10/19/16 21:11:32, V3975-01HD, 00:28:00:15, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3975/00_28_00_15.jpg, 439.220001220703, descend, robs, u, 20064317 _findIndex(): Looking for epoch secs 1476911524 ... Found time 1476911522 after 3 iterations. >>> p = 1505: annotations(): 1505, 1476911524, 10/19/16 21:12:04, V3975-01HD, 00:28:32:14, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3975/00_28_32_14.jpg, 439.649993896484, cruise, robs, u, 20064318 _findIndex(): Looking for epoch secs 1476911533 ... Found time 1476911535 after 7 iterations. >>> p = 1518: annotations(): 1518, 1476911533, 10/19/16 21:12:13, V3975-01HD, 00:28:41:14, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3975/00_28_41_14.jpg, 438.079986572266, cruise, robs, u, 20064319 _findIndex(): Looking for epoch secs 1476911577 ... Found time 1476911576 after 5 iterations. >>> p = 1559: annotations(): 1559, 1476911577, 10/19/16 21:12:57, V3975-01HD, 00:29:24:27, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3975/00_29_24_27.jpg, 439.980010986328, cruise, robs, u, 20064320 _findIndex(): Looking for epoch secs 1476911591 ... Found time 1476911589 after 7 iterations. >>> p = 1572: annotations(): 1572, 1476911591, 10/19/16 21:13:11, V3975-01HD, 00:29:39:27, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2016/293/accesses.txt at bin\geopdvc.pl line 625 ameGrabs/Ventana/images/3975/00_29_39_27.jpg, 440.339996337891, cruise, robs, u, 20064321 _findIndex(): Looking for epoch secs 1476911662 ... Found time 1476911657 after 6 iterations. >>> p = 1640: annotations(): 1640, 1476911662, 10/19/16 21:14:22, V3975-01HD, 00:30:50:25, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3975/00_30_50_25.jpg, 439.980010986328, cruise, robs, u, 20064322 _findIndex(): Looking for epoch secs 1476911676 ... Found time 1476911677 after 8 iterations. >>> p = 1660: annotations(): 1660, 1476911676, 10/19/16 21:14:36, V3975-01HD, 00:31:04:24, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3975/00_31_04_24.jpg, 440.010009765625, ascend, robs, u, 20064323 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3975anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 445.1 db", "T: 6.172 C", "S: 34.155", "O: 0.69 ml/l", "L: 85.07 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 445.6 db", "T: 6.166 C", "S: 34.156", "O: 0.681 ml/l", "L: 85.05 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 445.9 db", "T: 6.158 C", "S: 34.159", "O: 0.67 ml/l", "L: 85.07 %"] inline_name = vnta3975anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 444.4 db", "T: 6.177 C", "S: 34.153", "O: 0.699 ml/l", "L: 85.06 %"] placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 445.1 db", "T: 6.172 C", "S: 34.155", "O: 0.69 ml/l", "L: 85.07 %"] placeAnnotations(): Placing annotation 3: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 443.7 db", "T: 6.172 C", "S: 34.155", "O: 0.684 ml/l", "L: 85.04 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 445.6 db", "T: 6.166 C", "S: 34.156", "O: 0.681 ml/l", "L: 85.05 %"] placeAnnotations(): Placing annotation 5: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 445.9 db", "T: 6.163 C", "S: 34.157", "O: 0.676 ml/l", "L: 85.07 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 445.9 db", "T: 6.158 C", "S: 34.159", "O: 0.67 ml/l", "L: 85.07 %"] placeAnnotations(): Placing annotation 7: Ancillary data = ["", "P: 445.5 db", "T: 6.156 C", "S: 34.159", "O: 0.663 ml/l", "L: 85.06 %"] inline_name = vnta3975anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2016/vnta3975... frameGrabs(): matched 00_28_00_15 in