Running bin\geopdvc.pl at Sat Jul 12 03:02:03 2014 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3775 bin\geopdvc.pl: Getting Expedition object for diveno = 3775 and rname = vnta set_expd(): rov = vnta, diveno = 3775 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 = 3775 AND RovName = 'vnta' RS->Fields(0)->Value= 5003 RS->Fields(1)->Value= 1400098364 RS->Fields(2)->Value= 1400102532 RS->Fields(3)->Value= 5/14/2014 8:12:44 PM RS->Fields(4)->Value= 5/14/2014 9:22:12 PM set_expd(): $self->{EndDDD} = 134 set_expd(): $self->{StartEsecs} = 1400097164 set_expd(): $self->{EndEsecs} = 1400103732 set_expd(): $self->{EndDtg} = 5/14/2014 9:22:12 PM _readLogr(): Reading videologr data from 2014134datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1400097164 & 1400103732 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1400103733, self->{EndEsecs} = 1400103732 _readLogr(): #LOGHOST_SYSTEM_UTC = 655 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1400097172 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1400103723 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1400097172 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1400103723 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1400097044, Refined EndEsecs = 1400103852 _readLogr(): Reading videologr data from 2014134datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1400097044 & 1400103852 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1400103853, self->{EndEsecs} = 1400103852 _readLogr(): #LOGHOST_SYSTEM_UTC = 679 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1400097052 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1400103843 bin\geopdvc.pl: expdid = 5003 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 = 134 (looping to 134) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014134vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014134vnta.txt esecs, east, north, lat, lon, head, pres 1400098557, 0, 0, 36.749988, -122.103577, 320.9, 85.05 1400099058, 0, 0, 36.750398, -122.103813, 67.6, 287.52 1400099559, 0, 0, 36.750658, -122.102713, 88.7, 452.45 1400100060, 0, 0, 36.750930, -122.102807, 256.9, 468.14 1400100561, 0, 0, 36.749878, -122.104923, 189.4, 396.12 1400101062, 0, 0, 36.749998, -122.105660, 174.6, 339.19 1400101562, 0, 0, 36.749790, -122.105918, 175.7, 198.50 1400102063, 0, 0, 36.749667, -122.106713, 183.1, 131.92 1400102564, 0, 0, 36.749292, -122.106830, 254.0, 3.18 rovNav(): 134: 4599 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014134vnta.txt 4599 in tList 4599 in {self->{rovT}} 4599 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1400101410 & 1400099805 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): .............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 269.915500572458 rovGDCListRefs(): dStats->sample_range = 476.367110571789 rovGDCListRefs(): returning (1st elements): 1400098163 36.706025 -122.066097 18.0 2.75945100982498 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 134 (looping to 134) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014134vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014134vntaedited.txt esecs, east, north, lat, lon, head, pres 1400098557, 0, 0, 36.749988, -122.103577, 320.9, 85.05 1400099058, 0, 0, 36.750398, -122.103813, 67.6, 287.52 1400099559, 0, 0, 36.750658, -122.102713, 88.7, 452.45 1400100060, 0, 0, 36.750930, -122.102807, 256.9, 468.14 1400100561, 0, 0, 36.749878, -122.104923, 189.4, 396.12 1400101062, 0, 0, 36.749998, -122.105660, 174.6, 339.19 1400101562, 0, 0, 36.749790, -122.105918, 175.7, 198.50 1400102063, 0, 0, 36.749667, -122.106713, 183.1, 131.92 1400102564, 0, 0, 36.749292, -122.106830, 254.0, 3.18 rovNav(): 134: 4599 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014134vntaedited.txt 4599 in tList 4599 in {self->{rovT}} 4599 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1400101410 & 1400099805 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXXXXXXXXX....................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/134/accesses.txt at bin\geopdvc.pl line 2382 ..............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 269.915500572458 rovGDCListRefs(): dStats->sample_range = 476.367110571789 rovGDCListRefs(): returning (1st elements): 1400098163 36.706025 -122.066097 18.0 2.75945100982498 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.74991300 hash{lon} = -122.10479100 latMin = 30.749913 latMax = 42.749913 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.749913 AND 42.749913 AND Longitude BETWEEN -128.104791 AND -116.104791 Dive lat = 36.74991300, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.10479100 & lat = 36.74991300 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3775rov_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 = geo2014/vnta/vnta3775lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 679 shipNav(): $#{$self->{shipLat}}[last] = 36.756755 Position subsampling set to 4 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 = 4600 makeTracks(): Looping through 679 point of ship position data... makeTracks(): posSubsample = 4 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3775tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2014/vnta/vnta3775mergedCtdNav.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 '5/14/2014 8:12:44 PM' AND '5/14/2014 9:22:12 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '5/14/2014 8:12:44 PM' AND '5/14/2014 9:22:12 PM') _findIndex(): Looking for epoch secs 1400099852 ... Found time 1400099854 after 6 iterations. >>> p = 1688: annotations(): 1688, 1400099852, 05/14/14 20:37:32, V3775-01HD, 04:11:22:08, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_11_22_08.jpg, 475.410003662109, cruise, robs, u, 20055165 _findIndex(): Looking for epoch secs 1400099872 ... Found time 1400099872 after 7 iterations. >>> p = 1706: annotations(): 1706, 1400099872, 05/14/14 20:37:52, V3775-01HD, 04:11:42:22, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_11_42_22.jpg, 474.5, cruise, robs, u, 20055166 _findIndex(): Looking for epoch secs 1400099889 ... Found time 1400099890 after 2 iterations. >>> p = 1724: annotations(): 1724, 1400099889, 05/14/14 20:38:09, V3775-01HD, 04:11:59:22, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_11_59_22.jpg, 475.170013427734, cruise, robs, u, 20055167 _findIndex(): Looking for epoch secs 1400099907 ... Found time 1400099907 after 7 iterations. >>> p = 1741: annotations(): 1741, 1400099907, 05/14/14 20:38:27, V3775-01HD, 04:12:16:23, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_12_16_23.jpg, 475.679992675781, cruise, robs, u, 20055168 _findIndex(): Looking for epoch secs 1400099912 ... Found time 1400099907 after 7 iterations. >>> p = 1741: annotations(): 1741, 1400099912, 05/14/14 20:38:32, V3775-01HD, 04:12:22:23, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_12_22_23.jpg, 475.760009765625, cruise, robs, u, 20055169 _findIndex(): Looking for epoch secs 1400099917 ... Found time 1400099916 after 8 iterations. >>> p = 1750: annotations(): 1750, 1400099917, 05/14/14 20:38:37, V3775-01HD, 04:12:27:23, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_12_27_23.jpg, 475.540008544922, cruise, robs, u, 20055170 _findIndex(): Looking for epoch secs 1400099925 ... Found time 1400099925 after 6 iterations. >>> p = 1759: annotations(): 1759, 1400099925, 05/14/14 20:38:45, V3775-01HD, 04:12:35:23, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_12_35_23.jpg, 475.649993896484, cruise, robs, u, 20055171 _findIndex(): Looking for epoch secs 1400100067 ... Found time 1400100069 after 6 iterations. >>> p = 1903: annotations(): 1903, 1400100067, 05/14/14 20:41:07, V3775-01HD, 04:14:57:07, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_14_57_07.jpg, 464.309997558594, cruise, robs, u, 20055172 _findIndex(): Looking for epoch secs 1400100624 ... Found time 1400100627 after 7 iterations. >>> p = 2460: annotations(): 2460, 1400100624, 05/14/14 20:50:24, V3775-01HD, 04:24:14:24, Bathochordaeus stygius, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_24_14_24.jpg, 389.480010986328, cruise, robs, u, 20055173 _findIndex(): Looking for epoch secs 1400101664 ... Found time 1400101662 after 8 iterations. >>> p = 3493: annotations(): 3493, 1400101664, 05/14/14 21:07:44, V3775-01HD, 04:41:34:22, Bathochordaeus stygius, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_41_34_22.jpg, 175.309997558594, cruise, robs, u, 20055174 _findIndex(): Looking for epoch secs 1400101676 ... Found time 1400101671 after 7 iterations. >>> p = 3502: annotations(): 3502, 1400101676, 05/14/14 21:07:56, V3775-01HD, 04:41:46:22, Bathochordaeus stygius, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_41_46_22.jpg, 174.720001220703, cruise, robs, u, 20055175 _findIndex(): Looking for epoch secs 1400101686 ... Found time 1400101689 after 5 iterations. >>> p = 3520: annotations(): 3520, 1400101686, 05/14/14 21:08:06, V3775-01HD, 04:41:56:07, Bathochordaeus stygius, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_41_56_07.jpg, 174.649993896484, cruise, robs, u, 20055176 _findIndex(): Looking for epoch secs 1400102185 ... Found time 1400102184 after 8 iterations. >>> p = 4015: annotations(): 4015, 1400102185, 05/14/14 21:16:25, V3775-01HD, 04:50:15:23, Bathochordaeus stygius, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3775/04_50_15_23.jpg, 107.51000213623, cruise, robs, u, 20055180 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 176 db", "T: 8.678 C", "S: 34.097", "O: 1.395 ml/l", "L: 88.05 %"] inline_name = vnta3775anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 478.8 db", "T: 6.837 C", "S: 34.227", "O: 0.517 ml/l", "L: 88.07 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 480.3 db", "T: 6.835 C", "S: 34.227", "O: 0.518 ml/l", "L: 88.08 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 480.3 db", "T: 6.835 C", "S: 34.227", "O: 0.518 ml/l", "L: 88.08 %"] placeAnnotations(): Placing annotation 8: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 469.2 db", "T: 6.855 C", "S: 34.226", "O: 0.524 ml/l", "L: 88.12 %"] placeAnnotations(): Placing annotation 10: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 176 db", "T: 8.678 C", "S: 34.097", "O: 1.395 ml/l", "L: 88.05 %"] placeAnnotations(): Placing annotation 12: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 174.9 db", "T: 8.677 C", "S: 34.098", "O: 1.395 ml/l", "L: 88.04 %"] inline_name = vnta3775anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 479.9 db", "T: 6.835 C", "S: 34.228", "O: 0.519 ml/l", "L: 88.14 %"] placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 478.8 db", "T: 6.837 C", "S: 34.227", "O: 0.517 ml/l", "L: 88.07 %"] placeAnnotations(): Placing annotation 3: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 480 db", "T: 6.836 C", "S: 34.227", "O: 0.517 ml/l", "L: 88.14 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 480.3 db", "T: 6.835 C", "S: 34.227", "O: 0.518 ml/l", "L: 88.08 %"] placeAnnotations(): Placing annotation 5: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 480.3 db", "T: 6.835 C", "S: 34.227", "O: 0.518 ml/l", "L: 88.08 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 480.3 db", "T: 6.835 C", "S: 34.227", "O: 0.518 ml/l", "L: 88.08 %"] placeAnnotations(): Placing annotation 7: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 480.1 db", "T: 6.835 C", "S: 34.227", "O: 0.517 ml/l", "L: 88.14 %"] placeAnnotations(): Placing annotation 8: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 469.2 db", "T: 6.855 C", "S: 34.226", "O: 0.524 ml/l", "L: 88.12 %"] placeAnnotations(): Placing annotation 9: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 393.3 db", "T: 7.292 C", "S: 34.197", "O: 0.707 ml/l", "L: 88.23 %"] placeAnnotations(): Placing annotation 10: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 176 db", "T: 8.678 C", "S: 34.097", "O: 1.395 ml/l", "L: 88.05 %"] placeAnnotations(): Placing annotation 11: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 176 db", "T: 8.678 C", "S: 34.097", "O: frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/134/accesses.txt at bin\geopdvc.pl line 625 1.395 ml/l", "L: 88.05 %"] placeAnnotations(): Placing annotation 12: Bathochordaeus stygius Ancillary data = ["Bathochordaeus stygius", "P: 174.9 db", "T: 8.677 C", "S: 34.098", "O: 1.395 ml/l", "L: 88.04 %"] placeAnnotations(): Placing annotation 13: Ancillary data = ["", "P: 107.4 db", "T: 8.974 C", "S: 33.957", "O: 2.058 ml/l", "L: 87.94 %"] inline_name = vnta3775anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/vnta3775... frameGrabs(): matched 04_11_22_08 in