Running bin\geopdvc.pl at Sat Nov 14 03:00:55 2015 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3868 bin\geopdvc.pl: Getting Expedition object for diveno = 3868 and rname = vnta set_expd(): rov = vnta, diveno = 3868 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 = 3868 AND RovName = 'vnta' RS->Fields(0)->Value= 5346 RS->Fields(1)->Value= 1442438526 RS->Fields(2)->Value= 1442440370 RS->Fields(3)->Value= 9/16/2015 9:22:06 PM RS->Fields(4)->Value= 9/16/2015 9:52:50 PM set_expd(): $self->{EndDDD} = 259 set_expd(): $self->{StartEsecs} = 1442437326 set_expd(): $self->{EndEsecs} = 1442441570 set_expd(): $self->{EndDtg} = 9/16/2015 9:52:50 PM _readLogr(): Reading videologr data from 2015259datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1442437326 & 1442441570 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1442441572, self->{EndEsecs} = 1442441570 _readLogr(): #LOGHOST_SYSTEM_UTC = 423 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1442437331 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1442441562 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1442437331 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1442441562 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1442437206, Refined EndEsecs = 1442441690 _readLogr(): Reading videologr data from 2015259datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1442437206 & 1442441690 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1442441692, self->{EndEsecs} = 1442441690 _readLogr(): #LOGHOST_SYSTEM_UTC = 447 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1442437211 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1442441682 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 1442439065, 0, 0, 36.819213, -121.870070, 194.8, 73.55 1442439566, 0, 0, 36.818855, -121.869857, 138.4, 74.99 1442440067, 0, 0, 36.818682, -121.869682, 136.1, 60.29 rovNav(): 259: 1731 in tList after reading from \\atlas\RovNavEdit\2015\vnta\nav2015259vnta.txt 1731 in tList 1731 in {self->{rovT}} 1731 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1442440185 & 1442439555 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ...................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 72.7945529348782 rovGDCListRefs(): dStats->sample_range = 71.8906678564154 rovGDCListRefs(): returning (1st elements): 1442438530 36.715675 -122.187982 7.9 2.58078045239797 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 1442439065, 0, 0, 36.819219, -121.870085, 194.8, 73.55 1442439566, 0, 0, 36.818856, -121.869861, 138.4, 74.99 1442440067, 0, 0, 36.818682, -121.869688, 136.1, 60.29 rovNav(): 259: 1731 in tList after reading from \\atlas\RovNavEdit\2015\vnta\nav2015259vntaedited.txt 1731 in tList 1731 in {self->{rovT}} 1731 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1442440185 & 1442439555 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXX........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 72.7945527705692 rovGDCListRefs(): dStats->sample_range = 71.8906680768816 rovGDCListRefs(): returning (1st elements): 1442438530 36.716590 -122.185192 7.9 2.58078024359584 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.81885000 hash{lon} = -121.86988900 latMin = 30.81885 latMax = 42.81885 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.81885 AND 42.81885 AND Longitude BETWEEN -127.869889 AND -115.869889 Dive lat = 36.81885000, area = cencal bin\geopdvcframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/259/accesses.txt at bin\geopdvc.pl line 2382 .pl: Found area = cencal in GeoOrigin For midpoint lon = -121.86988900 & lat = 36.81885000 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3868rov_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/vnta3868lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 447 shipNav(): $#{$self->{shipLat}}[last] = 36.812000 Position subsampling set to 2 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 = 1732 makeTracks(): Looping through 447 point of ship position data... makeTracks(): posSubsample = 2 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3868tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2015/vnta/vnta3868mergedCtdNav.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 9:22:06 PM' AND '9/16/2015 9:52:50 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '9/16/2015 9:22:06 PM' AND '9/16/2015 9:52:50 PM') _findIndex(): Looking for epoch secs 1442438710 ... Found time 1442438711 after 7 iterations. >>> p = 74: annotations(): 74, 1442438710, 09/16/15 21:25:10, V3868-01HD, 00:00:40:12, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_00_40_12.jpg, , descend, lonny, u, 20058694 _findIndex(): Looking for epoch secs 1442438758 ... Found time 1442438758 after 6 iterations. >>> p = 121: annotations(): 121, 1442438758, 09/16/15 21:25:58, V3868-01HD, 00:01:28:13, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_01_28_13.jpg, , descend, lonny, u, 20058695 _findIndex(): Looking for epoch secs 1442438774 ... Found time 1442438772 after 5 iterations. >>> p = 135: annotations(): 135, 1442438774, 09/16/15 21:26:14, V3868-01HD, 00:01:44:13, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_01_44_13.jpg, , descend, lonny, u, 20058696 _findIndex(): Looking for epoch secs 1442439055 ... Found time 1442439055 after 6 iterations. >>> p = 418: annotations(): 418, 1442439055, 09/16/15 21:30:55, V3868-01HD, 00:06:24:16, bottle, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_06_24_16.jpg, , descend, lonny, u, 20058697 _findIndex(): Looking for epoch secs 1442439278 ... Found time 1442439279 after 7 iterations. >>> p = 641: annotations(): 641, 1442439278, 09/16/15 21:34:38, V3868-01HD, 00:10:07:28, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_10_07_28.jpg, , descend, lonny, u, 20058698 _findIndex(): Looking for epoch secs 1442439290 ... Found time 1442439286 after 2 iterations. >>> p = 648: annotations(): 648, 1442439290, 09/16/15 21:34:50, V3868-01HD, 00:10:20:13, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_10_20_13.jpg, , descend, lonny, u, 20058699 _findIndex(): Looking for epoch secs 1442439293 ... Found time 1442439292 after 7 iterations. >>> p = 654: annotations(): 654, 1442439293, 09/16/15 21:34:53, V3868-01HD, 00:10:23:13, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_10_23_13.jpg, , descend, lonny, u, 20058700 _findIndex(): Looking for epoch secs 1442439296 ... Found time 1442439299 after 6 iterations. >>> p = 661: annotations(): 661, 1442439296, 09/16/15 21:34:56, V3868-01HD, 00:10:25:29, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_10_25_29.jpg, , descend, lonny, u, 20058701 _findIndex(): Looking for epoch secs 1442439328 ... Found time 1442439326 after 6 iterations. >>> p = 688: annotations(): 688, 1442439328, 09/16/15 21:35:28, V3868-01HD, 00:10:58:16, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_10_58_16.jpg, , descend, lonny, u, 20058702 _findIndex(): Looking for epoch secs 1442439339 ... Found time 1442439340 after 4 iterations. >>> p = 702: annotations(): 702, 1442439339, 09/16/15 21:35:39, V3868-01HD, 00:11:09:04, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_11_09_04.jpg, , descend, lonny, u, 20058703 _findIndex(): Looking for epoch secs 1442439341 ... Found time 1442439340 after 4 iterations. >>> p = 702: annotations(): 702, 1442439341, 09/16/15 21:35:41, V3868-01HD, 00:11:11:04, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_11_11_04.jpg, , descend, lonny, u, 20058704 _findIndex(): Looking for epoch secs 1442439719 ... Found time 1442439719 after 2 iterations. >>> p = 1081: annotations(): 1081, 1442439719, 09/16/15 21:41:59, V3868-01HD, 00:17:29:16, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_17_29_16.jpg, , descend, lonny, u, 20058705 _findIndex(): Looking for epoch secs 1442439737 ... Found time 1442439732 after 6 iterations. >>> p = 1094: annotations(): 1094, 1442439737, 09/16/15 21:42:17, V3868-01HD, 00:17:47:19, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_17_47_19.jpg, , descend, lonny, u, 20058706 _findIndex(): Looking for epoch secs 1442439740 ... Found time 1442439739 after 7 iterations. >>> p = 1101: annotations(): 1101, 1442439740, 09/16/15 21:42:20, V3868-01HD, 00:17:50:04, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_17_50_04.jpg, , descend, lonny, u, 20058707 _findIndex(): Looking for epoch secs 1442439743 ... Found time 1442439746 after 5 iterations. >>> p = 1108: annotations(): 1108, 1442439743, 09/16/15 21:42:23, V3868-01HD, 00:17:53:04, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_17_53_04.jpg, , descend, lonny, u, 20058708 _findIndex(): Looking for epoch secs 1442439775 ... Found time 1442439774 after 4 iterations. >>> p = 1135: annotations(): 1135, 1442439775, 09/16/15 21:42:55, V3868-01HD, 00:18:24:28, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3868/00_18_24_28.jpg, , descend, lonny, u, 20058709 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.908 C", "S: 33.46", "O: 3.8 ml/l", "L: 82.46 %"] inline_name = vnta3868anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 67.6 db", "T: 12.975 C", "S: 33.361", "O: 4.6 ml/l", "L: 83.54 %"] placeAnnotations(): Placing annotation 4: physical object AncilframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/259/accesses.txt at bin\geopdvc.pl line 625 lary data = ["physical object", "P: 73.7 db", "T: 11.979 C", "S: 33.458", "O: 3.845 ml/l", "L: 82.4 %"] placeAnnotations(): Placing annotation 6: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.869 C", "S: 33.464", "O: 3.794 ml/l", "L: 82.33 %"] placeAnnotations(): Placing annotation 8: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.821 C", "S: 33.474", "O: 3.734 ml/l", "L: 82.43 %"] placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.908 C", "S: 33.46", "O: 3.8 ml/l", "L: 82.46 %"] placeAnnotations(): Placing annotation 12: physical object Ancillary data = ["physical object", "P: 74.9 db", "T: 11.554 C", "S: 33.495", "O: 3.541 ml/l", "L: 81.93 %"] placeAnnotations(): Placing annotation 14: physical object Ancillary data = ["physical object", "P: 74.9 db", "T: 11.558 C", "S: 33.495", "O: 3.542 ml/l", "L: 81.93 %"] placeAnnotations(): Placing annotation 16: Ancillary data = ["", "P: 74.9 db", "T: 11.558 C", "S: 33.495", "O: 3.54 ml/l", "L: 82.15 %"] inline_name = vnta3868anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical object Ancillary data = ["physical object", "P: 43.8 db", "T: 13.863 C", "S: 33.328", "O: 5.272 ml/l", "L: 83.57 %"] placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 67.6 db", "T: 12.975 C", "S: 33.361", "O: 4.6 ml/l", "L: 83.54 %"] placeAnnotations(): Placing annotation 3: bottle Ancillary data = ["bottle", "P: 69.9 db", "T: 12.789 C", "S: 33.386", "O: 4.442 ml/l", "L: 83.66 %"] placeAnnotations(): Placing annotation 4: physical object Ancillary data = ["physical object", "P: 73.7 db", "T: 11.979 C", "S: 33.458", "O: 3.845 ml/l", "L: 82.4 %"] placeAnnotations(): Placing annotation 5: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.869 C", "S: 33.464", "O: 3.794 ml/l", "L: 82.33 %"] placeAnnotations(): Placing annotation 6: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.869 C", "S: 33.464", "O: 3.794 ml/l", "L: 82.33 %"] placeAnnotations(): Placing annotation 7: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.869 C", "S: 33.464", "O: 3.794 ml/l", "L: 82.33 %"] placeAnnotations(): Placing annotation 8: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.821 C", "S: 33.474", "O: 3.734 ml/l", "L: 82.43 %"] placeAnnotations(): Placing annotation 9: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.924 C", "S: 33.46", "O: 3.813 ml/l", "L: 82.47 %"] placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.908 C", "S: 33.46", "O: 3.8 ml/l", "L: 82.46 %"] placeAnnotations(): Placing annotation 11: physical object Ancillary data = ["physical object", "P: 73.8 db", "T: 11.908 C", "S: 33.46", "O: 3.8 ml/l", "L: 82.46 %"] placeAnnotations(): Placing annotation 12: physical object Ancillary data = ["physical object", "P: 74.9 db", "T: 11.554 C", "S: 33.495", "O: 3.541 ml/l", "L: 81.93 %"] placeAnnotations(): Placing annotation 13: physical object Ancillary data = ["physical object", "P: 74.9 db", "T: 11.558 C", "S: 33.495", "O: 3.542 ml/l", "L: 81.93 %"] placeAnnotations(): Placing annotation 14: physical object Ancillary data = ["physical object", "P: 74.9 db", "T: 11.558 C", "S: 33.495", "O: 3.542 ml/l", "L: 81.93 %"] placeAnnotations(): Placing annotation 15: physical object Ancillary data = ["physical object", "P: 74.9 db", "T: 11.562 C", "S: 33.495", "O: 3.545 ml/l", "L: 82.04 %"] placeAnnotations(): Placing annotation 16: Ancillary data = ["", "P: 74.9 db", "T: 11.558 C", "S: 33.495", "O: 3.54 ml/l", "L: 82.15 %"] inline_name = vnta3868anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/vnta3868... frameGrabs(): matched 00_00_40_12 in [IMG]00_00_40_12.jpg18-Sep-2015 09:10 273K frameGrabs(): matched 00_01_28_13 in [IMG]00_01_28_13.jpg18-Sep-2015 09:10 259K frameGrabs(): matched 00_01_44_13 in [IMG]00_01_44_13.jpg18-Sep-2015 09:10 273K frameGrabs(): matched 00_06_24_16 in [IMG]00_06_24_16.jpg18-Sep-2015 09:10 265K frameGrabs(): matched 00_10_07_28 in [IMG]00_10_07_28.jpg18-Sep-2015 09:10 289K frameGrabs(): matched 00_10_20_13 in [IMG]00_10_20_13.jpg18-Sep-2015 09:10 273K frameGrabs(): matched 00_10_23_13 in [IMG]00_10_23_13.jpg18-Sep-2015 09:10 277K frameGrabs(): matched 00_10_25_29 in [IMG]00_10_25_29.jpg18-Sep-2015 09:10 283K frameGrabs(): matched 00_10_58_16 in [IMG]00_10_58_16.jpg18-Sep-2015 09:11 278K frameGrabs(): matched 00_11_09_04 in [IMG]00_11_09_04.jpg18-Sep-2015 09:11 325K frameGrabs(): matched 00_11_11_04 in [IMG]00_11_11_04.jpg18-Sep-2015 09:11 325K frameGrabs(): matched 00_17_29_16 in [IMG]00_17_29_16.jpg18-Sep-2015 09:11 304K frameGrabs(): matched 00_17_47_19 in [IMG]00_17_47_19.jpg18-Sep-2015 09:11 307K frameGrabs(): matched 00_17_50_04 in [IMG]00_17_50_04.jpg18-Sep-2015 09:11 277K frameGrabs(): matched 00_17_53_04 in [IMG]00_17_53_04.jpg18-Sep-2015 09:11 305K frameGrabs(): matched 00_18_24_28 in [IMG]00_18_24_28.jpg18-Sep-2015 09:11 280K iList = 00_00_40_12.jpg 00_01_28_13.jpg 00_01_44_13.jpg 00_06_24_16.jpg 00_10_07_28.jpg 00_10_20_13.jpg 00_10_23_13.jpg 00_10_25_29.jpg 00_10_58_16.jpg 00_11_09_04.jpg 00_11_11_04.jpg 00_17_29_16.jpg 00_17_47_19.jpg 00_17_50_04.jpg 00_17_53_04.jpg 00_18_24_28.jpg _findIndex(): Looking for epoch secs 1442438710 ... Found time 1442438711 after 7 iterations. >>> p = 74: frameGrabs(): index = 74 EXPD::frameGrabs(): 74: Time=1442438715, Depth=43.47, Lat=36.819529, Lon=-121.870151, Pres=43.8, Temp=13.863, Sal=33.328, O2=5.272, Light=83.57 _findIndex(): Looking for epoch secs 1442438758 ... Found time 1442438758 after 6 iterations. >>> p = 121: frameGrabs(): index = 121 EXPD::frameGrabs(): 121: Time=1442438760, Depth=67.09, Lat= 36.819428, Lon=-121.870030, Pres=67.6, Temp=12.975, Sal=33.361, O2=4.6, Light=83.54 _findIndex(): Looking for epoch secs 1442438774 ... Found time 1442438772 after 5 iterations. >>> p = 135: frameGrabs(): index = 135 EXPD::frameGrabs(): 135: Time=1442438775, Depth=69.37, Lat= 36.819421, Lon=-121.870031, Pres=69.9, Temp=12.789, Sal=33.386, O2=4.442, Light=83.66 _findIndex(): Looking for epoch secs 1442439055 ... Found time 1442439055 after 6 iterations. >>> p = 418: frameGrabs(): index = 418 EXPD::frameGrabs(): 418: Time=1442439060, Depth=73.14, Lat=36.819226, Lon=-121.870091, Pres=73.7, Temp=11.979, Sal=33.458, O2=3.845, Light=82.4 _findIndex(): Looking for epoch secs 1442439278 ... Found time 1442439279 after 7 iterations. >>> p = 641: frameGrabs(): index = 641 EXPD::frameGrabs(): 641: Time=1442439285, Depth=73.24, Lat= 36.818897, Lon=-121.870002, Pres=73.8, Temp=11.869, Sal=33.464, O2=3.794, Light=82.33 _findIndex(): Looking for epoch secs 1442439290 ... Found time 1442439286 after 2 iterations. >>> p = 648: frameGrabs(): index = 648 EXPD::frameGrabs(): 648: Time=1442439285, Depth=73.24, Lat=36.818887, Lon=-121.869990, Pres=73.8, Temp=11.869, Sal=33.464, O2=3.794, Light=82.33 _findIndex(): Looking for epoch secs 1442439293 ... Found time 1442439292 after 7 iterations. >>> p = 654: frameGrabs(): index = 654 EXPD::frameGrabs(): 654: Time=1442439285, Depth=73.24, Lat=36.818881, Lon=-121.869980, Pres=73.8, Temp=11.869, Sal=33.464, O2=3.794, Light=82.33 _findIndex(): Looking for epoch secs 1442439296 ... Found time 1442439299 after 6 iterations. >>> p = 661: frameGrabs(): index = 661 EXPD::frameGrabs(): 661: Time=1442439300, Depth=73.24, Lat= 36.818875, Lon=-121.869966, Pres=73.8, Temp=11.821, Sal=33.474, O2=3.734, Light=82.43 _findIndex(): Looking for epoch secs 1442439328 ... Found time 1442439326 after 6 iterations. >>> p = 688: frameGrabs(): index = 688 EXPD::frameGrabs(): 688: Time=1442439330, Depth=73.24, Lat=36.818853, Lon=-121.869931, Pres=73.8, Temp=11.924, Sal=33.46, O2=3.813, Light=82.47 _findIndex(): Looking for epoch secs 1442439339 ... Found time 1442439340 after 4 iterations. >>> p = 702: frameGrabs(): index = 702 EXPD::frameGrabs(): 702: Time=1442439345, Depth=73.24, Lat=36.818838, Lon=-121.869922, Pres=73.8, Temp=11.908, Sal=33.46, O2=3.8, Light=82.46 _findIndex(): Looking for epoch secs 1442439341 ... Found time 1442439340 after 4 iterations. >>> p = 702: frameGrabs(): index = 702 EXPD::frameGrabs(): 702: Time=1442439345, Depth=73.24, Lat=36.818838, Lon=-121.869922, Pres=73.8, Temp=11.908, Sal=33.46, O2=3.8, Light=82.46 _findIndex(): Looking for epoch secs 1442439719 ... Found time 1442439719 after 2 iterations. >>> p = 1081: frameGrabs(): index = 1081 EXPD::frameGrabs(): 1081: Time=1442439720, Depth=74.33, Lat= 36.818855, Lon=-121.869857, Pres=74.9, Temp=11.554, Sal=33.495, O2=3.541, Light=81.93 _findIndex(): Looking for epoch secs 1442439737 ... Found time 1442439732 after 6 iterations. >>> p = 1094: frameGrabs(): index = 1094 EXPD::frameGrabs(): 1094: Time=1442439735, Depth=74.33, Lat=36.818853, Lon=-121.869859, Pres=74.9, Temp=11.558, Sal=33.495, O2=3.542, Light=81.93 _findIndex(): Looking for epoch secs 1442439740 ... Found time 1442439739 after 7 iterations. >>> p = 1101: frameGrabs(): index = 1101 EXPD::frameGrabs(): 1101: Time=1442439735, Depth=74.33, Lat= 36.818851, Lon=-121.869859, Pres=74.9, Temp=11.558, Sal=33.495, O2=3.542, Light=81.93 _findIndex(): Looking for epoch secs 1442439743 ... Found time 1442439746 after 5 iterations. >>> p = 1108: frameGrabs(): index = 1108 EXPD::frameGrabs(): 1108: Time=1442439750, Depth=74.33, Lat=36.818849, Lon=-121.869860, Pres=74.9, Temp=11.562, Sal=33.495, O2=3.545, Light=82.04 _findIndex(): Looking for epoch secs 1442439775 ... Found time 1442439774 after 4 iterations. >>> p = 1135: frameGrabs(): index = 1135 EXPD::frameGrabs(): 1135: Time=1442439780, Depth=74.33, Lat= 36.818847, Lon=-121.869860, Pres=74.9, Temp=11.558, Sal=33.495, O2=3.54, Light=82.15 bin\geopdvc.pl: Number of images returned from expd->frameGrabs(every=>1)} = 16 bin\geopdvc.pl: Calling placeImages with every 10 image... placeImages(): Placing image 0 00_00_40_12.jpg 1442438710 fw= 0.0 cm XplaceImages(): indx = 74, geoPosition = 36.819529, -121.870151, -40.8316707700576, rovDepth = 40.8316707700576 placeImages(): Placing image 10 00_11_11_04.jpg 1442439341 fw= 0.0 cm XplaceImages(): indx = 702, geoPosition = 36.818838, -121.869922, -72.7548630276258, rovDepth = 72.7548630276258 inline_name = vnta3868fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 00_00_40_12.jpg 1442438710 fw= 0.0 cm XplaceImages(): indx = 74, geoPosition = 36.819529, -121.870151, -40.8316707700576, rovDepth = 40.8316707700576 placeImages(): Placing image 2 00_01_44_13.jpg 1442438774 fw= 0.0 cm XplaceImages(): indx = 135, geoPosition = 36.819421, -121.870031, -68.1507669151213, rovDepth = 68.1507669151213 placeImages(): Placing image 4 00_10_07_28.jpg 1442439278 fw= 0.0 cm XplaceImages(): indx = 641, geoPosition = 36.818897, -121.870002, -73.012847512417, rovDepth = 73.012847512417 placeImages(): Placing image 6 00_10_23_13.jpg 1442439293 fw= 0.0 cm XplaceImages(): indx = 654, geoPosition = 36.818881, -121.869980, -72.9533126759683, rovDepth = 72.9533126759683 placeImages(): Placing image 8 00_10_58_16.jpg 1442439328 fw= 0.0 cm .placeImages(): indx = 688, geoPosition = 36.818853, -121.869931, -72.8540879180858, rovDepth = 72.8540879180858 placeImages(): Placing image 10 00_11_11_04.jpg 1442439341 fw= 0.0 cm .placeImages(): indx = 702, geoPosition = 36.818838, -121.869922, -72.7548630276258, rovDepth = 72.7548630276258 placeImages(): Placing image 12 00_17_47_19.jpg 1442439737 fw= 0.0 cm XplaceImages(): indx = 1094, geoPosition = 36.818853, -121.869859, -74.352379343658, rovDepth = 74.352379343658 placeImages(): Placing image 14 00_17_53_04.jpg 1442439743 fw= 0.0 cm XplaceImages(): indx = 1108, geoPosition = 36.818849, -121.869860, -74.0547064545328, rovDepth = 74.0547064545328 inline_name = vnta3868fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 00_00_40_12.jpg 1442438710 fw= 0.0 cm XplaceImages(): indx = 74, geoPosition = 36.819529, -121.870151, -40.8316707700576, rovDepth = 40.8316707700576 placeImages(): Placing image 1 00_01_28_13.jpg 1442438758 fw= 0.0 cm XplaceImages(): indx = 121, geoPosition = 36.819428, -121.870030, -66.7814262091072, rovDepth = 66.7814262091072 placeImages(): Placing image 2 00_01_44_13.jpg 1442438774 fw= 0.0 cm XplaceImages(): indx = 135, geoPosition = 36.819421, -121.870031, -68.1507669151213, rovDepth = 68.1507669151213 placeImages(): Placing image 3 00_06_24_16.jpg 1442439055 fw= 0.0 cm .placeImages(): indx = 418, geoPosition = 36.819226, -121.870091, -72.9930004087389, rovDepth = 72.9930004087389 placeImages(): Placing image 4 00_10_07_28.jpg 1442439278 fw= 0.0 cm XplaceImages(): indx = 641, geoPosition = 36.818897, -121.870002, -73.012847512417, rovDepth = 73.012847512417 placeImages(): Placing image 5 00_10_20_13.jpg 1442439290 fw= 0.0 cm .placeImages(): indx = 648, geoPosition = 36.818887, -121.869990, -73.1219949214965, rovDepth = 73.1219949214965 placeImages(): Placing image 6 00_10_23_13.jpg 1442439293 fw= 0.0 cm .placeImages(): indx = 654, geoPosition = 36.818881, -121.869980, -72.9533126759683, rovDepth = 72.9533126759683 placeImages(): Placing image 7 00_10_25_29.jpg 1442439296 fw= 0.0 cm .placeImages(): indx = 661, geoPosition = 36.818875, -121.869966, -73.0624600912022, rovDepth = 73.0624600912022 placeImages(): Placing image 8 00_10_58_16.jpg 1442439328 fw= 0.0 cm .placeImages(): indx = 688, geoPosition = 36.818853, -121.869931, -72.8540879180858, rovDepth = 72.8540879180858 placeImages(): Placing image 9 00_11_09_04.jpg 1442439339 fw= 0.0 cm .placeImages(): indx = 702, geoPosition = 36.818838, -121.869922, -72.7548630276258, rovDepth = 72.7548630276258 placeImages(): Placing image 10 00_11_11_04.jpg 1442439341 fw= 0.0 cm .placeImages(): indx = 702, geoPosition = 36.818838, -121.869922, -72.7548630276258, rovDepth = 72.7548630276258 placeImages(): Placing image 11 00_17_29_16.jpg 1442439719 fw= 0.0 cm XplaceImages(): indx = 1081, geoPosition = 36.818855, -121.869857, -74.3424569069977, rovDepth = 74.3424569069977 placeImages(): Placing image 12 00_17_47_19.jpg 1442439737 fw= 0.0 cm XplaceImages(): indx = 1094, geoPosition = 36.818853, -121.869859, -74.352379343658, rovDepth = 74.352379343658 placeImages(): Placing image 13 00_17_50_04.jpg 1442439740 fw= 0.0 cm .placeImages(): indx = 1101, geoPosition = 36.818851, -121.869859, -74.0249391259444, rovDepth = 74.0249391259444 placeImages(): Placing image 14 00_17_53_04.jpg 1442439743 fw= 0.0 cm .placeImages(): indx = 1108, geoPosition = 36.818849, -121.869860, -74.0547064545328, rovDepth = 74.0547064545328 placeImages(): Placing image 15 00_18_24_28.jpg 1442439775 fw= 0.0 cm .placeImages(): indx = 1135, geoPosition = 36.818847, -121.869860, -74.2233878398696, rovDepth = 74.2233878398696 inline_name = vnta3868fg01.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 '9/16/2015 9:22:06 PM' AND '9/16/2015 9:52:50 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2015/vnta/vnta3868.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',5346,'/3Dreplay/3D.asp?dives=vnta3868','vnta3868','','','',3868 Executing sql: UPDATE Dive SET DiveLatMid = 36.8188, DiveLonMid = -121.8699, DiveDepthMid = -72.8 WHERE RovName = 'vnta' AND DiveNumber = 3868