Running bin\geopdvc.pl at Sun May 8 03:00:15 2011 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3610 bin\geopdvc.pl: Getting Expedition object for diveno = 3610 and rname = vnta set_expd(): rov = vnta, diveno = 3610 set_expd(): $self->{EndDDD} = 069 set_expd(): $self->{StartEsecs} = 1299775308 set_expd(): $self->{EndEsecs} = 1299780885 set_expd(): $self->{EndDtg} = 3/10/2011 5:54:45 PM _readLogr(): Reading videologr data from 2011069datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1299775308 & 1299780885 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1299780893, self->{EndEsecs} = 1299780885 _readLogr(): #LOGHOST_SYSTEM_UTC = 557 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1299775312 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1299780883 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1299775312 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1299780883 refineStartAndEndEsecs(): setting StartEsecs to 1299775308 refineStartAndEndEsecs(): setting EndEsecs to 1299775322 refineStartAndEndEsecs(): numMinBack = 21.7666666666667, numMinForward = 7.13333333333333 refineStartAndEndEsecs(): Refined StartEsecs = 1299775202, Refined EndEsecs = 1299780113 _readLogr(): Reading videologr data from 2011069datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1299775202 & 1299780113 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1299780123, self->{EndEsecs} = 1299780113 _readLogr(): #LOGHOST_SYSTEM_UTC = 490 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1299775211 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1299780113 bin\geopdvc.pl: expdid = 4488 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 = 069 (looping to 069) Does file exist?: \\tornado\TempNav\2011\vnta\nav2011069vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2011\vnta\nav2011069vnta.txt esecs, east, north, lat, lon, head, pres 1299776845, 0, 0, 36.750465, -122.109595, 107.3, 84.27 1299777346, 0, 0, 36.749820, -122.105867, 347.1, 170.18 1299777847, 0, 0, 36.750395, -122.105905, 7.4, 329.46 1299778348, 0, 0, 36.751295, -122.105862, 339.7, 337.13 1299778849, 0, 0, 36.749978, -122.106413, 218.6, 316.48 1299779350, 0, 0, 36.748898, -122.105883, 342.6, 133.65 rovNav(): 069: 3430 in tList after reading from \\tornado\TempNav\2011\vnta\nav2011069vnta.txt 3430 in tList 3430 in {self->{rovT}} 3430 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1299779205 & 1299776895 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 197.423908478178 rovGDCListRefs(): dStats->sample_range = 335.243150812796 rovGDCListRefs(): returning (1st elements): 1299776345 36.736782 -122.086663 48.6 2.58077563529746 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 069 (looping to 069) Does file exist?: \\tornado\TempNav\2011\vnta\nav2011069vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2011\vnta\nav2011069vntaedited.txt esecs, east, north, lat, lon, head, pres 1299776845, 0, 0, 36.750451, -122.109540, 107.3, 84.27 1299777346, 0, 0, 36.749853, -122.105890, 347.1, 170.18 1299777847, 0, 0, 36.750439, -122.105868, 7.4, 329.46 1299778348, 0, 0, 36.751291, -122.105863, 339.7, 337.13 1299778849, 0, 0, 36.750061, -122.106368, 218.6, 316.48 1299779350, 0, 0, 36.748919, -122.105911, 342.6, 133.65 rovNav(): 069: 3430 in tList after reading from \\tornado\TempNav\2011\vnta\nav2011069vntaedited.txt rovNav(): Initial # seconds to fill at beginning of dive = 1143 starting at StartEsecs = 1299775202 rovNav(): Initial # seconds to fill at end of dive = 152 ending at EndEsecs =1299780113 rovNav(): LOGHOST_SYSTEM_UTC[0] = 1299775211 rovNav(): $LOGHOST_SYSTEM_UTC[end] = 1299780113 rovNav(): numMinBack = 21.6166666666667, numMinForward = 7.13333333333333 rovNav(): Refined StartEsecs = 1299775202, Refined EndEsecs = 1299780113 rovNav(): Refined # seconds to fill at beginning of dive = 1143 starting at StartEsecs = 1299775202 rovNav(): Refined # seconds to fill at end of dive = 152 ending at EndEsecs =1299780113 rovNav(): num tList = 3430 rovNav(): num eList = 3430 rovNav(): Adding data to begining of dive from logr indices 0 .. 113 rovNav(): Adding data to end of dive from logr indices 475 .. 490 rovNav(): num in tList now = 3560 rovNav(): num in eList now = 3560 3560 in tList 3560 in {self->{rovT}} 3560 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1299779205 & 1299776895 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXX............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 188.241043392625 rovGDCListRefs(): dStats->sample_range = 342.238287401025 rovGDCListRefs(): returning (1st elements): 1299775211 36.751295 -122.102825 205.0 -5 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.75028300 hash{lon} = -122.10589300 latMin = 30.750283 latMax = 42.750283 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.750283 AND 42.750283 AND Longitude BETWEEN -128.105893 AND -116.105893 Dive lat = 36.75028300, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.10589300 & lat = 36.75028300 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta36frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/069/accesses.txt at bin\geopdvc.pl line 2382 10rov_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 = geo2011/vnta/vnta3610lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = ptlo shipNav(): $#{$self->{shipLat}} = 490 shipNav(): $#{$self->{shipLat}}[last] = 36.746910 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 = 3561 makeTracks(): Looping through 490 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3610tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2011/vnta/vnta3610mergedCtdNav.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 = 'Point Lobos') AND (RecordedDate BETWEEN '3/10/2011 5:01:48 PM' AND '3/10/2011 5:54:45 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '3/10/2011 5:01:48 PM' AND '3/10/2011 5:54:45 PM') _findIndex(): Looking for epoch secs 1299778074 ... Found time 1299778069 after 5 iterations. >>> p = 1835: annotations(): 1835, 1299778074, 03/10/11 17:27:54, V3610-01HD, 00:28:12:00, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_28_12_00.jpg, 335.260009765625, descend, kwalz, , 20046149 _findIndex(): Looking for epoch secs 1299778087 ... Found time 1299778083 after 7 iterations. >>> p = 1849: annotations(): 1849, 1299778087, 03/10/11 17:28:07, V3610-01HD, 00:28:25:16, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_28_25_16.jpg, 335.720001220703, descend, kwalz, , 20046150 _findIndex(): Looking for epoch secs 1299778121 ... Found time 1299778125 after 4 iterations. >>> p = 1891: annotations(): 1891, 1299778121, 03/10/11 17:28:41, V3610-01HD, 00:28:58:17, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_28_58_17.jpg, 335.820007324219, descend, kwalz, , 20046151 _findIndex(): Looking for epoch secs 1299778126 ... Found time 1299778125 after 4 iterations. >>> p = 1891: annotations(): 1891, 1299778126, 03/10/11 17:28:46, V3610-01HD, 00:29:04:19, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_29_04_19.jpg, 335.619995117188, descend, kwalz, , 20046152 _findIndex(): Looking for epoch secs 1299778157 ... Found time 1299778152 after 6 iterations. >>> p = 1918: annotations(): 1918, 1299778157, 03/10/11 17:29:17, V3610-01HD, 00:29:35:03, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_29_35_03.jpg, 336.160003662109, descend, kwalz, , 20046153 _findIndex(): Looking for epoch secs 1299778209 ... Found time 1299778209 after 6 iterations. >>> p = 1974: annotations(): 1974, 1299778209, 03/10/11 17:30:09, V3610-01HD, 00:30:25:22, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_30_25_22.jpg, 333.959991455078, descend, kwalz, , 20046154 _findIndex(): Looking for epoch secs 1299778225 ... Found time 1299778223 after 7 iterations. >>> p = 1988: annotations(): 1988, 1299778225, 03/10/11 17:30:25, V3610-01HD, 00:30:41:10, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_30_41_10.jpg, 335.450012207031, descend, kwalz, , 20046155 _findIndex(): Looking for epoch secs 1299778231 ... Found time 1299778230 after 8 iterations. >>> p = 1995: annotations(): 1995, 1299778231, 03/10/11 17:30:31, V3610-01HD, 00:30:47:26, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_30_47_26.jpg, 335.059997558594, descend, kwalz, , 20046156 _findIndex(): Looking for epoch secs 1299778256 ... Found time 1299778257 after 8 iterations. >>> p = 2022: annotations(): 2022, 1299778256, 03/10/11 17:30:56, V3610-01HD, 00:31:13:10, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_31_13_10.jpg, 335.029998779297, descend, kwalz, , 20046157 _findIndex(): Looking for epoch secs 1299778266 ... Found time 1299778264 after 6 iterations. >>> p = 2029: annotations(): 2029, 1299778266, 03/10/11 17:31:06, V3610-01HD, 00:31:22:25, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_31_22_25.jpg, 334.920013427734, descend, kwalz, , 20046158 _findIndex(): Looking for epoch secs 1299778297 ... Found time 1299778292 after 5 iterations. >>> p = 2057: annotations(): 2057, 1299778297, 03/10/11 17:31:37, V3610-01HD, 00:31:53:11, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_31_53_11.jpg, 334.440002441406, descend, kwalz, , 20046159 _findIndex(): Looking for epoch secs 1299778476 ... Found time 1299778473 after 7 iterations. >>> p = 2238: annotations(): 2238, 1299778476, 03/10/11 17:34:36, V3610-01HD, 00:34:52:19, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_34_52_19.jpg, 333.450012207031, descend, kwalz, , 20046160 _findIndex(): Looking for epoch secs 1299778550 ... Found time 1299778550 after 8 iterations. >>> p = 2315: annotations(): 2315, 1299778550, 03/10/11 17:35:50, V3610-01HD, 00:36:06:11, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_36_06_11.jpg, 333.940002441406, descend, kwalz, , 20046161 _findIndex(): Looking for epoch secs 1299778582 ... Found time 1299778584 after 7 iterations. >>> p = 2349: annotations(): 2349, 1299778582, 03/10/11 17:36:22, V3610-01HD, 00:36:39:12, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3610/00_36_39_12.jpg, 334.230010986328, ascend, kwalz, , 20046162 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.1 db", "T: 6.894 C", "S: 34.176", "O: 0.701 ml/l", "L: 90.58 %"] inline_name = vnta3610anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.8 db", "T: 6.879 C", "S: 34.179", "O: 0.701 ml/l", "L: 90.62 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 340.1 db", "T: 6.88 C", "S: 34.178", "O: 0.694 ml/l", "L: 90.61 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 338.9 db", "T: 6.897 C", "S: 34.174", "O: 0.697 ml/l", "L: 90.56 %"] placeAnnotations(): Placing annotation 8: MframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/069/accesses.txt at bin\geopdvc.pl line 625 idwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.2 db", "T: 6.892 C", "S: 34.175", "O: 0.7 ml/l", "L: 90.58 %"] placeAnnotations(): Placing annotation 10: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.1 db", "T: 6.894 C", "S: 34.176", "O: 0.701 ml/l", "L: 90.58 %"] placeAnnotations(): Placing annotation 12: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 338.6 db", "T: 6.888 C", "S: 34.177", "O: 0.709 ml/l", "L: 90.56 %"] placeAnnotations(): Placing annotation 14: Ancillary data = ["", "P: 338.8 db", "T: 6.905 C", "S: 34.174", "O: 0.71 ml/l", "L: 90.47 %"] inline_name = vnta3610anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.5 db", "T: 6.873 C", "S: 34.178", "O: 0.707 ml/l", "L: 90.6 %"] placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.8 db", "T: 6.879 C", "S: 34.179", "O: 0.701 ml/l", "L: 90.62 %"] placeAnnotations(): Placing annotation 3: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 340.1 db", "T: 6.88 C", "S: 34.178", "O: 0.694 ml/l", "L: 90.61 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 340.1 db", "T: 6.88 C", "S: 34.178", "O: 0.694 ml/l", "L: 90.61 %"] placeAnnotations(): Placing annotation 5: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 340.1 db", "T: 6.877 C", "S: 34.177", "O: 0.693 ml/l", "L: 90.61 %"] placeAnnotations(): Placing annotation 6: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 338.9 db", "T: 6.897 C", "S: 34.174", "O: 0.697 ml/l", "L: 90.56 %"] placeAnnotations(): Placing annotation 7: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.2 db", "T: 6.892 C", "S: 34.175", "O: 0.7 ml/l", "L: 90.58 %"] placeAnnotations(): Placing annotation 8: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.2 db", "T: 6.892 C", "S: 34.175", "O: 0.7 ml/l", "L: 90.58 %"] placeAnnotations(): Placing annotation 9: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.1 db", "T: 6.894 C", "S: 34.176", "O: 0.701 ml/l", "L: 90.58 %"] placeAnnotations(): Placing annotation 10: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.1 db", "T: 6.894 C", "S: 34.176", "O: 0.701 ml/l", "L: 90.58 %"] placeAnnotations(): Placing annotation 11: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 339.3 db", "T: 6.895 C", "S: 34.175", "O: 0.703 ml/l", "L: 90.6 %"] placeAnnotations(): Placing annotation 12: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 338.6 db", "T: 6.888 C", "S: 34.177", "O: 0.709 ml/l", "L: 90.56 %"] placeAnnotations(): Placing annotation 13: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 338.3 db", "T: 6.893 C", "S: 34.137", "O: 0.709 ml/l", "L: 90.53 %"] placeAnnotations(): Placing annotation 14: Ancillary data = ["", "P: 338.8 db", "T: 6.905 C", "S: 34.174", "O: 0.71 ml/l", "L: 90.47 %"] inline_name = vnta3610anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/vnta3610... frameGrabs(): matched 00_28_12_00 in