Running bin\geopdvc.pl at Fri Jun 2 03:00:04 2017 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 4018 bin\geopdvc.pl: Getting Expedition object for diveno = 4018 and rname = vnta set_expd(): rov = vnta, diveno = 4018 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 = 4018 AND RovName = 'vnta' RS->Fields(0)->Value= 5907 RS->Fields(1)->Value= 1491313920 RS->Fields(2)->Value= 1491316891 RS->Fields(3)->Value= 4/4/2017 1:52:00 PM RS->Fields(4)->Value= 4/4/2017 2:41:31 PM set_expd(): $self->{EndDDD} = 094 set_expd(): $self->{StartEsecs} = 1491312720 set_expd(): $self->{EndEsecs} = 1491318091 set_expd(): $self->{EndDtg} = 4/4/2017 2:41:31 PM _readLogr(): Reading videologr data from 2017094datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1491312720 & 1491318091 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1491318101, self->{EndEsecs} = 1491318091 _readLogr(): #LOGHOST_SYSTEM_UTC = 536 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1491312730 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1491318091 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1491312730 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1491318091 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1491312600, Refined EndEsecs = 1491318211 _readLogr(): Reading videologr data from 2017094datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1491312600 & 1491318211 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1491318221, self->{EndEsecs} = 1491318211 _readLogr(): #LOGHOST_SYSTEM_UTC = 560 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1491312610 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1491318211 bin\geopdvc.pl: expdid = 5907 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 = 094 (looping to 094) Does file exist?: \\atlas\RovNavEdit\2017\vnta\nav2017094vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2017\vnta\nav2017094vnta.txt esecs, east, north, lat, lon, head, pres 1491314422, 0, 0, 36.795660, -121.821772, 129.4, 50.88 1491314923, 0, 0, 36.794782, -121.822058, 213.5, 50.84 1491315424, 0, 0, 36.793683, -121.822532, 212.1, 50.35 1491315925, 0, 0, 36.793168, -121.822978, 213.2, 25.06 1491316426, 0, 0, 36.792568, -121.823663, 210.6, 25.10 rovNav(): 094: 2964 in tList after reading from \\atlas\RovNavEdit\2017\vnta\nav2017094vnta.txt 2964 in tList 2964 in {self->{rovT}} 2964 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1491315540 & 1491315150 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ...........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 25.0320156981822 rovGDCListRefs(): dStats->sample_range = 49.0778740048576 rovGDCListRefs(): returning (1st elements): 1491313923 36.796030 -121.822352 60.7 2.87854024233425 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 094 (looping to 094) Does file exist?: \\atlas\RovNavEdit\2017\vnta\nav2017094vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2017\vnta\nav2017094vntaedited.txt esecs, east, north, lat, lon, head, pres 1491314422, 0, 0, 36.795660, -121.821776, 129.4, 50.88 1491314923, 0, 0, 36.794779, -121.822059, 213.5, 50.84 1491315424, 0, 0, 36.793708, -121.822504, 212.1, 50.35 1491315925, 0, 0, 36.793191, -121.823018, 213.2, 25.06 1491316426, 0, 0, 36.792587, -121.823641, 210.6, 25.10 rovNav(): 094: 2964 in tList after reading from \\atlas\RovNavEdit\2017\vnta\nav2017094vntaedited.txt 2964 in tList 2964 in {self->{rovT}} 2964 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1491315540 & 1491315150 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXX........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 25.0320157579917 rovGDCListRefs(): dStats->sample_range = 49.0778738990228 rovGDCListRefs(): returning (1st elements): 1491313923 36.796011 -121.822381 60.7 2.8785402471743 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.79373100 hash{lon} = -121.82246300 latMin = 30.793731 latMax = 42.793731 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.793731 AND 42.793731 AND Longitude BETWEEN -127.822463 AND -115.822463 Dive lat = 36.79373100, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -121.82246300 & lat = 36.79373100 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta4018rov_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 = geo2017/vnta/vnta4018lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 560 shipNav(): $#{$self->{shipLat}}[last] = 36.793243 Position subsampling set to 3 setROVcolorlines(): Assigning color line for Light... varColors = LightColors index0 = 0.5027 0.4221 0.0000 setROVcolorlines(): Assigning color line for O2... varColors = O2Colors index0 = 0.0000 0frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2017/094/accesses.txt at bin\geopdvc.pl line 2382 .4951 0.5049 setROVcolorlines(): Assigning color line for Sal... varColors = SalColors index0 = 1.0000 0.4940 0.0000 setROVcolorlines(): Assigning color line for Temp... varColors = TempColors index0 = 0.2140 1.0000 0.0000 makeTracks(): n = 2965 makeTracks(): Looping through 560 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta4018tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2017/vnta/vnta4018mergedCtdNav.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 '4/4/2017 1:52:00 PM' AND '4/4/2017 2:41:31 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '4/4/2017 1:52:00 PM' AND '4/4/2017 2:41:31 PM') _findIndex(): Looking for epoch secs 1491314284 ... Found time 1491314281 after 7 iterations. >>> p = 358: annotations(): 358, 1491314284, 04/04/17 13:58:04, V4018-01HD, 00:08:53:26, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_08_53_26.jpg, 50.2099990844727, descend, schlin, u, 20066509 _findIndex(): Looking for epoch secs 1491314490 ... Found time 1491314490 after 7 iterations. >>> p = 566: annotations(): 566, 1491314490, 04/04/17 14:01:30, V4018-01HD, 00:12:19:20, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_12_19_20.jpg, 50.2999992370605, starttransect, schlin, u, 20066510 _findIndex(): Looking for epoch secs 1491314538 ... Found time 1491314536 after 7 iterations. >>> p = 612: annotations(): 612, 1491314538, 04/04/17 14:02:18, V4018-01HD, 00:13:08:03, gauge, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_13_08_03.jpg, 50.2200012207031, transect, schlin, u, 20066511 _findIndex(): Looking for epoch secs 1491314813 ... Found time 1491314814 after 7 iterations. >>> p = 890: annotations(): 890, 1491314813, 04/04/17 14:06:53, V4018-01HD, 00:17:42:10, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_17_42_10.jpg, 50.3400001525879, transect, schlin, u, 20066512 _findIndex(): Looking for epoch secs 1491315027 ... Found time 1491315023 after 7 iterations. >>> p = 1099: annotations(): 1099, 1491315027, 04/04/17 14:10:27, V4018-01HD, 00:21:16:04, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_21_16_04.jpg, 50.3600006103516, transect, schlin, u, 20066513 _findIndex(): Looking for epoch secs 1491315074 ... Found time 1491315069 after 7 iterations. >>> p = 1145: annotations(): 1145, 1491315074, 04/04/17 14:11:14, V4018-01HD, 00:22:03:02, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_22_03_02.jpg, 50.4000015258789, transect, schlin, u, 20066514 _findIndex(): Looking for epoch secs 1491315230 ... Found time 1491315232 after 7 iterations. >>> p = 1307: annotations(): 1307, 1491315230, 04/04/17 14:13:50, V4018-01HD, 00:24:38:13, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_24_38_13.jpg, 50.4300003051758, transect, schlin, u, 20066515 _findIndex(): Looking for epoch secs 1491315387 ... Found time 1491315383 after 6 iterations. >>> p = 1458: annotations(): 1458, 1491315387, 04/04/17 14:16:27, V4018-01HD, 00:27:16:08, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_27_16_08.jpg, 50.4799995422363, endtransect, schlin, u, 20066516 _findIndex(): Looking for epoch secs 1491315523 ... Found time 1491315522 after 6 iterations. >>> p = 1597: annotations(): 1597, 1491315523, 04/04/17 14:18:43, V4018-01HD, 00:29:31:04, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_29_31_04.jpg, 24.7000007629395, cruise, schlin, u, 20066517 _findIndex(): Looking for epoch secs 1491315528 ... Found time 1491315533 after 7 iterations. >>> p = 1608: annotations(): 1608, 1491315528, 04/04/17 14:18:48, V4018-01HD, 00:29:36:19, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_29_36_19.jpg, 24.6900005340576, starttransect, schlin, u, 20066518 _findIndex(): Looking for epoch secs 1491315613 ... Found time 1491315615 after 6 iterations. >>> p = 1690: annotations(): 1690, 1491315613, 04/04/17 14:20:13, V4018-01HD, 00:31:02:01, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_31_02_01.jpg, 24.6700000762939, transect, schlin, u, 20066519 _findIndex(): Looking for epoch secs 1491315773 ... Found time 1491315778 after 2 iterations. >>> p = 1852: annotations(): 1852, 1491315773, 04/04/17 14:22:53, V4018-01HD, 00:33:41:11, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_33_41_11.jpg, 24.9899997711182, transect, schlin, u, 20066520 _findIndex(): Looking for epoch secs 1491315985 ... Found time 1491315986 after 6 iterations. >>> p = 2060: annotations(): 2060, 1491315985, 04/04/17 14:26:25, V4018-01HD, 00:37:13:20, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_37_13_20.jpg, 24.7099990844727, transect, schlin, u, 20066521 _findIndex(): Looking for epoch secs 1491316386 ... Found time 1491316381 after 5 iterations. >>> p = 2454: annotations(): 2454, 1491316386, 04/04/17 14:33:06, V4018-01HD, 00:43:53:08, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_43_53_08.jpg, 24.7600002288818, endtransect, schlin, u, 20066522 _findIndex(): Looking for epoch secs 1491316578 ... Found time 1491316577 after 7 iterations. >>> p = 2650: annotations(): 2650, 1491316578, 04/04/17 14:36:18, V4018-01HD, 00:47:06:01, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4018/00_47_06_01.jpg, 10.3800001144409, ascend, schlin, u, 20066523 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 26.3 db", "T: 9.35 C", "S: 33.821", "O: 2.585 ml/l", "L: 64.92 %"] inline_name = vnta4018anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: gauge Ancillary data = ["gauge", "P: 51.8 db", "T: 9.174 C", "S: 33.875", "O: 2.446 ml/l", "L: 69.17 %"] placeAnnotations(): Placing annotation 4: physical object Ancillary data = ["physical object", "P: 52 db", "T: 9.147 C", "S: 33.883", "O: 2.406 ml/l", "L: 67.99 %"] placeAnnotations(): Placing annotation 6: physical object Ancillary data = ["physical object", "P: 52 db", "T: 9.133 C", "S: 33.886", "O: 2.401 ml/l", "L: 69.84 %"] placeAnnotations(): Placing annotation 8: physical object Ancillary data = ["physical object", "P: 52.1 db", "T: 9.105 C", "S: 33.895", "O: 2.334 ml/l", "L: 67.72 %"] placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 26.3 db", "T: 9.35 C", "S: 33.821", "O: 2.585 ml/l", "L: 64.92 %"] placeAnnotations(): Placing annotation 12: physical object Ancillary data = ["physical object", "P: 26.5 db", "T: 9.408 C", "S: 33.803", "O: 2.659 ml/l", "L: 66.65 %"] placeAnnotations(): Placing annotation 14: physical object Ancillary data = ["physical object", "P: 26.5 db", "T: 9.295 C", "S: 33.839", "O: 2.528 ml/l", "L: 63.68 %"] inline_name = vnta4018anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical object Ancillary data = ["physical object", "P: 51.6 db", "T: 9.158 C", "S: 33.88", "O: 2.431 ml/l", "L: 70.33 %"] placeAnnotations(): Placing annotation 2: gauge Ancillary data = ["gauge", "P: 51.8 db", "T: 9.174 C", "S: frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2017/094/accesses.txt at bin\geopdvc.pl line 625 33.875", "O: 2.446 ml/l", "L: 69.17 %"] placeAnnotations(): Placing annotation 3: physical object Ancillary data = ["physical object", "P: 51.8 db", "T: 9.171 C", "S: 33.876", "O: 2.447 ml/l", "L: 70.48 %"] placeAnnotations(): Placing annotation 4: physical object Ancillary data = ["physical object", "P: 52 db", "T: 9.147 C", "S: 33.883", "O: 2.406 ml/l", "L: 67.99 %"] placeAnnotations(): Placing annotation 5: physical object Ancillary data = ["physical object", "P: 52 db", "T: 9.127 C", "S: 33.888", "O: 2.391 ml/l", "L: 69 %"] placeAnnotations(): Placing annotation 6: physical object Ancillary data = ["physical object", "P: 52 db", "T: 9.133 C", "S: 33.886", "O: 2.401 ml/l", "L: 69.84 %"] placeAnnotations(): Placing annotation 7: physical object Ancillary data = ["physical object", "P: 52.1 db", "T: 9.121 C", "S: 33.89", "O: 2.375 ml/l", "L: 67.66 %"] placeAnnotations(): Placing annotation 8: physical object Ancillary data = ["physical object", "P: 52.1 db", "T: 9.105 C", "S: 33.895", "O: 2.334 ml/l", "L: 67.72 %"] placeAnnotations(): Placing annotation 9: physical object Ancillary data = ["physical object", "P: 26.4 db", "T: 9.338 C", "S: 33.825", "O: 2.559 ml/l", "L: 64.77 %"] placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 26.3 db", "T: 9.35 C", "S: 33.821", "O: 2.585 ml/l", "L: 64.92 %"] placeAnnotations(): Placing annotation 11: physical object Ancillary data = ["physical object", "P: 26.3 db", "T: 9.372 C", "S: 33.815", "O: 2.61 ml/l", "L: 65.8 %"] placeAnnotations(): Placing annotation 12: physical object Ancillary data = ["physical object", "P: 26.5 db", "T: 9.408 C", "S: 33.803", "O: 2.659 ml/l", "L: 66.65 %"] placeAnnotations(): Placing annotation 13: physical object Ancillary data = ["physical object", "P: 26.5 db", "T: 9.354 C", "S: 33.82", "O: 2.592 ml/l", "L: 65.06 %"] placeAnnotations(): Placing annotation 14: physical object Ancillary data = ["physical object", "P: 26.5 db", "T: 9.295 C", "S: 33.839", "O: 2.528 ml/l", "L: 63.68 %"] placeAnnotations(): Placing annotation 15: Ancillary data = ["", "P: 12.1 db", "T: 9.546 C", "S: 33.757", "O: 2.879 ml/l", "L: 73.2 %"] inline_name = vnta4018anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2017/vnta4018... frameGrabs(): matched 00_08_53_26 in [IMG]00_08_53_26.jpg 2017-04-11 00:37 252K  frameGrabs(): matched 00_12_19_20 in [IMG]00_12_19_20.jpg 2017-04-11 00:37 241K  frameGrabs(): matched 00_13_08_03 in [IMG]00_13_08_03.jpg 2017-04-11 00:37 203K  frameGrabs(): matched 00_17_42_10 in [IMG]00_17_42_10.jpg 2017-04-11 00:37 201K  frameGrabs(): matched 00_21_16_04 in [IMG]00_21_16_04.jpg 2017-04-11 00:37 201K  frameGrabs(): matched 00_22_03_02 in [IMG]00_22_03_02.jpg 2017-04-11 00:37 202K  frameGrabs(): matched 00_24_38_13 in [IMG]00_24_38_13.jpg 2017-04-11 00:37 201K  frameGrabs(): matched 00_27_16_08 in [IMG]00_27_16_08.jpg 2017-04-11 00:37 198K  frameGrabs(): matched 00_29_31_04 in [IMG]00_29_31_04.jpg 2017-04-11 00:37 201K  frameGrabs(): matched 00_29_36_19 in [IMG]00_29_36_19.jpg 2017-04-11 00:37 208K  frameGrabs(): matched 00_31_02_01 in [IMG]00_31_02_01.jpg 2017-04-11 00:37 204K  frameGrabs(): matched 00_33_41_11 in [IMG]00_33_41_11.jpg 2017-04-11 00:37 207K  frameGrabs(): matched 00_37_13_20 in [IMG]00_37_13_20.jpg 2017-04-11 00:37 207K  frameGrabs(): matched 00_43_53_08 in [IMG]00_43_53_08.jpg 2017-04-11 00:37 207K  frameGrabs(): matched 00_47_06_01 in [IMG]00_47_06_01.jpg 2017-04-11 00:37 271K  iList = 00_08_53_26.jpg 00_12_19_20.jpg 00_13_08_03.jpg 00_17_42_10.jpg 00_21_16_04.jpg 00_22_03_02.jpg 00_24_38_13.jpg 00_27_16_08.jpg 00_29_31_04.jpg 00_29_36_19.jpg 00_31_02_01.jpg 00_33_41_11.jpg 00_37_13_20.jpg 00_43_53_08.jpg 00_47_06_01.jpg _findIndex(): Looking for epoch secs 1491314284 ... Found time 1491314281 after 7 iterations. >>> p = 358: frameGrabs(): index = 358 EXPD::frameGrabs(): 358: Time=1491314280, Depth=51.21, Lat= 36.795841, Lon=-121.822058, Pres=51.6, Temp=9.158, Sal=33.88, O2=2.431, Light=70.33 _findIndex(): Looking for epoch secs 1491314490 ... Found time 1491314490 after 7 iterations. >>> p = 566: frameGrabs(): index = 566 EXPD::frameGrabs(): 566: Time=1491314490, Depth=51.41, Lat= 36.795577, Lon=-121.821633, Pres=51.8, Temp=9.174, Sal=33.875, O2=2.446, Light=69.17 _findIndex(): Looking for epoch secs 1491314538 ... Found time 1491314536 after 7 iterations. >>> p = 612: frameGrabs(): index = 612 EXPD::frameGrabs(): 612: Time=1491314535, Depth=51.41, Lat=36.795488, Lon=-121.821547, Pres=51.8, Temp=9.171, Sal=33.876, O2=2.447, Light=70.48 _findIndex(): Looking for epoch secs 1491314813 ... Found time 1491314814 after 7 iterations. >>> p = 890: frameGrabs(): index = 890 EXPD::frameGrabs(): 890: Time=1491314820, Depth=51.61, Lat= 36.795031, Lon=-121.821989, Pres=52, Temp=9.147, Sal=33.883, O2=2.406, Light=67.99 _findIndex(): Looking for epoch secs 1491315027 ... Found time 1491315023 after 7 iterations. >>> p = 1099: frameGrabs(): index = 1099 EXPD::frameGrabs(): 1099: Time=1491315030, Depth=51.61, Lat= 36.794545, Lon=-121.822148, Pres=52, Temp=9.127, Sal=33.888, O2=2.391, Light=69 _findIndex(): Looking for epoch secs 1491315074 ... Found time 1491315069 after 7 iterations. >>> p = 1145: frameGrabs(): index = 1145 EXPD::frameGrabs(): 1145: Time=1491315075, Depth=51.61, Lat= 36.794442, Lon=-121.822186, Pres=52, Temp=9.133, Sal=33.886, O2=2.401, Light=69.84 _findIndex(): Looking for epoch secs 1491315230 ... Found time 1491315232 after 7 iterations. >>> p = 1307: frameGrabs(): index = 1307 EXPD::frameGrabs(): 1307: Time=1491315225, Depth=51.71, Lat= 36.794081, Lon=-121.822339, Pres=52.1, Temp=9.121, Sal=33.89, O2=2.375, Light=67.66 _findIndex(): Looking for epoch secs 1491315387 ... Found time 1491315383 after 6 iterations. >>> p = 1458: frameGrabs(): index = 1458 EXPD::frameGrabs(): 1458: Time=1491315390, Depth=51.71, Lat=36.793772, Lon=-121.822482, Pres=52.1, Temp=9.105, Sal=33.895, O2=2.334, Light=67.72 _findIndex(): Looking for epoch secs 1491315523 ... Found time 1491315522 after 6 iterations. >>> p = 1597: frameGrabs(): index = 1597 EXPD::frameGrabs(): 1597: Time=1491315525, Depth=26.2, Lat= 36.793674, Lon=-121.822453, Pres=26.4, Temp=9.338, Sal=33.825, O2=2.559, Light=64.77 _findIndex(): Looking for epoch secs 1491315528 ... Found time 1491315533 after 7 iterations. >>> p = 1608: frameGrabs(): index = 1608 EXPD::frameGrabs(): 1608: Time=1491315540, Depth=26.1, Lat=36.793663, Lon=-121.822465, Pres=26.3, Temp=9.35, Sal=33.821, O2=2.585, Light=64.92 _findIndex(): Looking for epoch secs 1491315613 ... Found time 1491315615 after 6 iterations. >>> p = 1690: frameGrabs(): index = 1690 EXPD::frameGrabs(): 1690: Time=1491315615, Depth=26.1, Lat= 36.793600, Lon=-121.822542, Pres=26.3, Temp=9.372, Sal=33.815, O2=2.61, Light=65.8 _findIndex(): Looking for epoch secs 1491315773 ... Found time 1491315778 after 2 iterations. >>> p = 1852: frameGrabs(): index = 1852 EXPD::frameGrabs(): 1852: Time=1491315780, Depth=26.3, Lat= 36.793389, Lon=-121.822788, Pres=26.5, Temp=9.408, Sal=33.803, O2=2.659, Light=66.65 _findIndex(): Looking for epoch secs 1491315985 ... Found time 1491315986 after 6 iterations. >>> p = 2060: frameGrabs(): index = 2060 EXPD::frameGrabs(): 2060: Time=1491315990, Depth=26.3, Lat= 36.793114, Lon=-121.823117, Pres=26.5, Temp=9.354, Sal=33.82, O2=2.592, Light=65.06 _findIndex(): Looking for epoch secs 1491316386 ... Found time 1491316381 after 5 iterations. >>> p = 2454: frameGrabs(): index = 2454 EXPD::frameGrabs(): 2454: Time=1491316380, Depth=26.3, Lat=36.792612, Lon=-121.823611, Pres=26.5, Temp=9.295, Sal=33.839, O2=2.528, Light=63.68 _findIndex(): Looking for epoch secs 1491316578 ... Found time 1491316577 after 7 iterations. >>> p = 2650: frameGrabs(): index = 2650 EXPD::frameGrabs(): 2650: Time=1491316575, Depth=12.01, Lat= 36.792600, Lon=-121.823672, Pres=12.1, Temp=9.546, Sal=33.757, O2=2.879, Light=73.2 bin\geopdvc.pl: Number of images returned from expd->frameGrabs(every=>1)} = 15 bin\geopdvc.pl: Calling placeImages with every 10 image... placeImages(): Placing image 0 00_08_53_26.jpg 1491314284 fw= 0.0 cm XplaceImages(): indx = 358, geoPosition = 36.795841, -121.822058, -50.3884190975882, rovDepth = 50.3884190975882 placeImages(): Placing image 10 00_31_02_01.jpg 1491315613 fw= 0.0 cm XplaceImages(): indx = 1690, geoPosition = 36.793600, -121.822542, -24.6647955386147, rovDepth = 24.6647955386147 inline_name = vnta4018fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 00_08_53_26.jpg 1491314284 fw= 0.0 cm XplaceImages(): indx = 358, geoPosition = 36.795841, -121.822058, -50.3884190975882, rovDepth = 50.3884190975882 placeImages(): Placing image 2 00_13_08_03.jpg 1491314538 fw= 0.0 cm XplaceImages(): indx = 612, geoPosition = 36.795488, -121.821547, -50.1998719521515, rovDepth = 50.1998719521515 placeImages(): Placing image 4 00_21_16_04.jpg 1491315027 fw= 0.0 cm XplaceImages(): indx = 1099, geoPosition = 36.794545, -121.822148, -50.2991123395739, rovDepth = 50.2991123395739 placeImages(): Placing image 6 00_24_38_13.jpg 1491315230 fw= 0.0 cm XplaceImages(): indx = 1307, geoPosition = 36.794081, -121.822339, -50.3685797177264, rovDepth = 50.3685797177264 placeImages(): Placing image 8 00_29_31_04.jpg 1491315523 fw= 0.0 cm XplaceImages(): indx = 1597, geoPosition = 36.793674, -121.822453, -24.6846451139545, rovDepth = 24.6846451139545 placeImages(): Placing image 10 00_31_02_01.jpg 1491315613 fw= 0.0 cm XplaceImages(): indx = 1690, geoPosition = 36.793600, -121.822542, -24.6647955386147, rovDepth = 24.6647955386147 placeImages(): Placing image 12 00_37_13_20.jpg 1491315985 fw= 0.0 cm XplaceImages(): indx = 2060, geoPosition = 36.793114, -121.823117, -24.8235944478841, rovDepth = 24.8235944478841 placeImages(): Placing image 14 00_47_06_01.jpg 1491316578 fw= 0.0 cm XplaceImages(): indx = 2650, geoPosition = 36.792600, -121.823672, -10.3824083617422, rovDepth = 10.3824083617422 inline_name = vnta4018fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 00_08_53_26.jpg 1491314284 fw= 0.0 cm XplaceImages(): indx = 358, geoPosition = 36.795841, -121.822058, -50.3884190975882, rovDepth = 50.3884190975882 placeImages(): Placing image 1 00_12_19_20.jpg 1491314490 fw= 0.0 cm XplaceImages(): indx = 566, geoPosition = 36.795577, -121.821633, -50.4181911090428, rovDepth = 50.4181911090428 placeImages(): Placing image 2 00_13_08_03.jpg 1491314538 fw= 0.0 cm XplaceImages(): indx = 612, geoPosition = 36.795488, -121.821547, -50.1998719521515, rovDepth = 50.1998719521515 placeImages(): Placing image 3 00_17_42_10.jpg 1491314813 fw= 0.0 cm XplaceImages(): indx = 890, geoPosition = 36.795031, -121.821989, -50.3388046403272, rovDepth = 50.3388046403272 placeImages(): Placing image 4 00_21_16_04.jpg 1491315027 fw= 0.0 cm XplaceImages(): indx = 1099, geoPosition = 36.794545, -121.822148, -50.2991123395739, rovDepth = 50.2991123395739 placeImages(): Placing image 5 00_22_03_02.jpg 1491315074 fw= 0.0 cm .placeImages(): indx = 1145, geoPosition = 36.794442, -121.822186, -50.4578906159772, rovDepth = 50.4578906159772 placeImages(): Placing image 6 00_24_38_13.jpg 1491315230 fw= 0.0 cm XplaceImages(): indx = 1307, geoPosition = 36.794081, -121.822339, -50.3685797177264, rovDepth = 50.3685797177264 placeImages(): Placing image 7 00_27_16_08.jpg 1491315387 fw= 0.0 cm XplaceImages(): indx = 1458, geoPosition = 36.793772, -121.822482, -50.3487338646747, rovDepth = 50.3487338646747 placeImages(): Placing image 8 00_29_31_04.jpg 1491315523 fw= 0.0 cm XplaceImages(): indx = 1597, geoPosition = 36.793674, -121.822453, -24.6846451139545, rovDepth = 24.6846451139545 placeImages(): Placing image 9 00_29_36_19.jpg 1491315528 fw= 0.0 cm .placeImages(): indx = 1608, geoPosition = 36.793663, -121.822465, -24.8732175416943, rovDepth = 24.8732175416943 placeImages(): Placing image 10 00_31_02_01.jpg 1491315613 fw= 0.0 cm .placeImages(): indx = 1690, geoPosition = 36.793600, -121.822542, -24.6647955386147, rovDepth = 24.6647955386147 placeImages(): Placing image 11 00_33_41_11.jpg 1491315773 fw= 0.0 cm XplaceImages(): indx = 1852, geoPosition = 36.793389, -121.822788, -24.6052467754504, rovDepth = 24.6052467754504 placeImages(): Placing image 12 00_37_13_20.jpg 1491315985 fw= 0.0 cm XplaceImages(): indx = 2060, geoPosition = 36.793114, -121.823117, -24.8235944478841, rovDepth = 24.8235944478841 placeImages(): Placing image 13 00_43_53_08.jpg 1491316386 fw= 0.0 cm XplaceImages(): indx = 2454, geoPosition = 36.792612, -121.823611, -24.8732198550584, rovDepth = 24.8732198550584 placeImages(): Placing image 14 00_47_06_01.jpg 1491316578 fw= 0.0 cm XplaceImages(): indx = 2650, geoPosition = 36.792600, -121.823672, -10.3824083617422, rovDepth = 10.3824083617422 inline_name = vnta4018fg01.wrl bin\geopdvc.pl: Samples: samples(): Executing sql: SELECT DateDiff(ss, '01/01/70', CollectionEventDtg) AS Esecs, CollectionVIMSConcept, FrameGrabImageURL, SampleID, CollectionRefName FROM vwCollSamplePerson WHERE (CollectionEventDTG BETWEEN '4/4/2017 1:52:00 PM' AND '4/4/2017 2:41:31 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2017/vnta/vnta4018.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',5907,'/3Dreplay/3D.asp?dives=vnta4018','vnta4018','','','',4018 Executing sql: UPDATE Dive SET DiveLatMid = 36.7937, DiveLonMid = -121.8225, DiveDepthMid = -25.0 WHERE RovName = 'vnta' AND DiveNumber = 4018