Running bin\geopdvc.pl at Sun Feb 2 03:01:49 2014 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3749 bin\geopdvc.pl: Getting Expedition object for diveno = 3749 and rname = vnta set_expd(): rov = vnta, diveno = 3749 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 = 3749 AND RovName = 'vnta' RS->Fields(0)->Value= 4900 RS->Fields(1)->Value= 1386279382 RS->Fields(2)->Value= 1386282537 RS->Fields(3)->Value= 12/5/2013 9:36:22 PM RS->Fields(4)->Value= 12/5/2013 10:28:57 PM set_expd(): $self->{EndDDD} = 339 set_expd(): $self->{StartEsecs} = 1386278182 set_expd(): $self->{EndEsecs} = 1386283737 set_expd(): $self->{EndDtg} = 12/5/2013 10:28:57 PM _readLogr(): Reading videologr data from 2013339datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1386278182 & 1386283737 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1386283747, self->{EndEsecs} = 1386283737 _readLogr(): #LOGHOST_SYSTEM_UTC = 555 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1386278186 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1386283737 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1386278186 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1386283737 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1386278062, Refined EndEsecs = 1386283857 _readLogr(): Reading videologr data from 2013339datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1386278062 & 1386283857 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1386283867, self->{EndEsecs} = 1386283857 _readLogr(): #LOGHOST_SYSTEM_UTC = 579 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1386278066 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1386283857 bin\geopdvc.pl: expdid = 4900 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 = 339 (looping to 339) Does file exist?: \\atlas\RovNavEdit\2013\vnta\nav2013339vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2013\vnta\nav2013339vnta.txt esecs, east, north, lat, lon, head, pres 1386279813, 0, 0, 36.749033, -122.103092, 41.0, 121.42 1386280313, 0, 0, 36.749397, -122.102005, 9.8, 304.20 1386280814, 0, 0, 36.750318, -122.101955, 306.4, 370.76 1386281315, 0, 0, 36.749035, -122.102363, 223.9, 278.52 1386281816, 0, 0, 36.748215, -122.102228, 323.5, 143.29 1386282317, 0, 0, 36.747587, -122.101903, 238.0, 7.91 rovNav(): 339: 3369 in tList after reading from \\atlas\RovNavEdit\2013\vnta\nav2013339vnta.txt 3369 in tList 3369 in {self->{rovT}} 3369 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1386281700 & 1386280815 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): .....................................................XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX..................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 179.523879205834 rovGDCListRefs(): dStats->sample_range = 372.162459705963 rovGDCListRefs(): returning (1st elements): 1386279363 36.691307 -122.044480 31.6 2.5510078991706 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 339 (looping to 339) Does file exist?: \\atlas\RovNavEdit\2013\vnta\nav2013339vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2013\vnta\nav2013339vntaedited.txt esecs, east, north, lat, lon, head, pres 1386279813, 0, 0, 36.749064, -122.103049, 41.0, 121.42 1386280313, 0, 0, 36.749500, -122.101987, 9.8, 304.20 1386280814, 0, 0, 36.750285, -122.101949, 306.4, 370.76 1386281315, 0, 0, 36.749127, -122.102251, 223.9, 278.52 1386281816, 0, 0, 36.748228, -122.102223, 323.5, 143.29 1386282317, 0, 0, 36.747368, -122.101773, 238.0, 7.91 rovNav(): 339: 3369 in tList after reading from \\atlas\RovNavEdit\2013\vnta\nav2013339vntaedited.txt 3369 in tList 3369 in {self->{rovT}} 3369 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1386281700 & 1386280815 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXX.................................XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX..................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 179.52387957899 rovGDCListRefs(): dStats->sample_range = 372.162464255563 rovGDCListRefs(): returning (1st elements): 1386279363 36.744221 -122.098325 31.6 2.55099596337142 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.74907200 hash{lon} = -122.10200000 latMin = 30.749072 latMax = 42.749072 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.749072 AND 42.749072 AND Longitude BETWEEN -128.102 AND -116.102 Dive lat = 36.74907200, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.10200000 & lat = 36.74907200 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3749rov_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 = geo2013/vnta/frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2013/339/accesses.txt at bin\geopdvc.pl line 2382 vnta3749lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 579 shipNav(): $#{$self->{shipLat}}[last] = 36.755805 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 = 3370 makeTracks(): Looping through 579 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3749tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2013/vnta/vnta3749mergedCtdNav.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 '12/5/2013 9:36:22 PM' AND '12/5/2013 10:28:57 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '12/5/2013 9:36:22 PM' AND '12/5/2013 10:28:57 PM') _findIndex(): Looking for epoch secs 1386280660 ... Found time 1386280660 after 8 iterations. >>> p = 1295: annotations(): 1295, 1386280660, 12/05/13 21:57:40, V3749-01HD, 00:19:09:15, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_19_09_15.jpg, 371.880004882813, cruise, ventana, u, 20052892 _findIndex(): Looking for epoch secs 1386280689 ... Found time 1386280693 after 7 iterations. >>> p = 1328: annotations(): 1328, 1386280689, 12/05/13 21:58:09, V3749-01HD, 00:19:38:14, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_19_38_14.jpg, 372.369995117188, cruise, ventana, u, 20052893 _findIndex(): Looking for epoch secs 1386280719 ... Found time 1386280719 after 7 iterations. >>> p = 1354: annotations(): 1354, 1386280719, 12/05/13 21:58:39, V3749-01HD, 00:20:08:14, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_20_08_14.jpg, 373.399993896484, cruise, ventana, u, 20052894 _findIndex(): Looking for epoch secs 1386280728 ... Found time 1386280733 after 4 iterations. >>> p = 1368: annotations(): 1368, 1386280728, 12/05/13 21:58:48, V3749-01HD, 00:20:16:28, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_20_16_28.jpg, 373.579986572266, cruise, ventana, u, 20052895 _findIndex(): Looking for epoch secs 1386280733 ... Found time 1386280733 after 4 iterations. >>> p = 1368: annotations(): 1368, 1386280733, 12/05/13 21:58:53, V3749-01HD, 00:20:21:28, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_20_21_28.jpg, 373.459991455078, cruise, ventana, u, 20052896 _findIndex(): Looking for epoch secs 1386280738 ... Found time 1386280733 after 4 iterations. >>> p = 1368: annotations(): 1368, 1386280738, 12/05/13 21:58:58, V3749-01HD, 00:20:26:28, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_20_26_28.jpg, 373.049987792969, cruise, ventana, u, 20052897 _findIndex(): Looking for epoch secs 1386280805 ... Found time 1386280804 after 8 iterations. >>> p = 1439: annotations(): 1439, 1386280805, 12/05/13 22:00:05, V3749-01HD, 00:21:33:11, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_21_33_11.jpg, 369.200012207031, cruise, ventana, u, 20052898 _findIndex(): Looking for epoch secs 1386280821 ... Found time 1386280824 after 7 iterations. >>> p = 1459: annotations(): 1459, 1386280821, 12/05/13 22:00:21, V3749-01HD, 00:21:49:25, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_21_49_25.jpg, 366.109985351563, cruise, ventana, u, 20052899 _findIndex(): Looking for epoch secs 1386280825 ... Found time 1386280824 after 7 iterations. >>> p = 1459: annotations(): 1459, 1386280825, 12/05/13 22:00:25, V3749-01HD, 00:21:53:25, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_21_53_25.jpg, 365.290008544922, cruise, ventana, u, 20052900 _findIndex(): Looking for epoch secs 1386281814 ... Found time 1386281813 after 6 iterations. >>> p = 2446: annotations(): 2446, 1386281814, 12/05/13 22:16:54, V3749-01HD, 00:38:21:26, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_38_21_26.jpg, 142.259994506836, cruise, ventana, u, 20052901 _findIndex(): Looking for epoch secs 1386282536 ... Found time 1386282539 after 7 iterations. >>> p = 3171: annotations(): 3171, 1386282536, 12/05/13 22:28:56, V3749-01HD, 00:51:02:03, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_51_02_03.jpg, 5.71000003814697, cruise, ventana, u, 20052902 _findIndex(): Looking for epoch secs 1386282536 ... Found time 1386282539 after 7 iterations. >>> p = 3171: annotations(): 3171, 1386282536, 12/05/13 22:28:56, V3749-01HD, 00:51:08:02, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3749/00_51_08_02.jpg, 5.71000003814697, cruise, ventana, u, 20052903 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 141.1 db", "T: 9.586 C", "S: 33.906", "O: 2.144 ml/l", "L: 91.4 %"] inline_name = vnta3749anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 374.8 db", "T: 7.3 C", "S: 34.161", "O: 0.892 ml/l", "L: 91.44 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 375.4 db", "T: 7.296 C", "S: 34.162", "O: 0.888 ml/l", "L: 91.45 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 375.4 db", "T: 7.296 C", "S: 34.162", "O: 0.888 ml/l", "L: 91.45 %"] placeAnnotations(): Placing annotation 8: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 367.3 db", "T: 7.32 C", "S: 34.156", "O: 0.904 ml/l", "L: 91.3 %"] placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 141.1 db", "T: 9.586 C", "S: 33.906", "O: 2.144 ml/l", "L: 91.4 %"] placeAnnotations(): Placing annotation 12: Ancillary data = ["", "P: db", "T: C", "S: ", "O: ml/l", "L: %"] inline_name = vnta3749anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 374.3 db", "T: 7.306 C", "S: 34.161", "O: 0.893 ml/l", "L: 91.43 %"] placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 374.8 db", "T: 7.3 C", "S: 34.161", "O: 0.892 ml/l", "L: 91.44 %"] placeAnnotations(): Placing annotation 3: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 375.8 db", "T: 7.299 C", "S: 34.162", "O: 0.889 ml/l", "L: 91.44 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 375.4 db", "T: 7.296 C", "S: 34.162", "O: 0.888 ml/l", "L: 91.45 %"] placeAnnotations(): Placing annotation 5: Midwater RespiromeframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2013/339/accesses.txt at bin\geopdvc.pl line 625 try System Ancillary data = ["Midwater Respirometry System", "P: 375.4 db", "T: 7.296 C", "S: 34.162", "O: 0.888 ml/l", "L: 91.45 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 375.4 db", "T: 7.296 C", "S: 34.162", "O: 0.888 ml/l", "L: 91.45 %"] placeAnnotations(): Placing annotation 7: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 372.4 db", "T: 7.305 C", "S: 34.16", "O: 0.894 ml/l", "L: 91.45 %"] placeAnnotations(): Placing annotation 8: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 367.3 db", "T: 7.32 C", "S: 34.156", "O: 0.904 ml/l", "L: 91.3 %"] placeAnnotations(): Placing annotation 9: physical object Ancillary data = ["physical object", "P: 367.3 db", "T: 7.32 C", "S: 34.156", "O: 0.904 ml/l", "L: 91.3 %"] placeAnnotations(): Placing annotation 10: physical object Ancillary data = ["physical object", "P: 141.1 db", "T: 9.586 C", "S: 33.906", "O: 2.144 ml/l", "L: 91.4 %"] placeAnnotations(): Placing annotation 11: physical object Ancillary data = ["physical object", "P: db", "T: C", "S: ", "O: ml/l", "L: %"] placeAnnotations(): Placing annotation 12: Ancillary data = ["", "P: db", "T: C", "S: ", "O: ml/l", "L: %"] inline_name = vnta3749anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2013/vnta3749... frameGrabs(): matched 00_19_09_15 in