Running bin\geopdvc.pl at Tue Jan 25 15:58:21 2011 on host EPHYRA-VM Command line: bin\geopdvc.pl -rov vnta -dive 3484 bin\geopdvc.pl: Getting Expedition object for diveno = 3484 and rname = vnta set_expd(): rov = vnta, diveno = 3484 set_expd(): $self->{EndDDD} = 008 set_expd(): $self->{StartEsecs} = 1262984109 set_expd(): $self->{EndEsecs} = 1262987706 set_expd(): $self->{EndDtg} = 1/8/2010 9:35:06 PM _readLogr(): Reading videologr data from 2010008datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1262984109 & 1262987706 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1262987715, self->{EndEsecs} = 1262987706 _readLogr(): #LOGHOST_SYSTEM_UTC = 359 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1262984114 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1262987705 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1262984114 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1262987705 refineStartAndEndEsecs(): setting StartEsecs to 1262984109 refineStartAndEndEsecs(): setting EndEsecs to 1262984714 refineStartAndEndEsecs(): numMinBack = 11.9166666666667, numMinForward = 2.63333333333333 refineStartAndEndEsecs(): Refined StartEsecs = 1262984594, Refined EndEsecs = 1262986664 _readLogr(): Reading videologr data from 2010008datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1262984594 & 1262986664 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1262986674, self->{EndEsecs} = 1262986664 _readLogr(): #LOGHOST_SYSTEM_UTC = 206 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1262984604 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1262986664 bin\geopdvc.pl: expdid = 4250 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 = 008 (looping to 008) Does file exist?: \\tornado\TempNav\2010\vnta\nav2010008vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2010\vnta\nav2010008vnta.txt esecs, east, north, lat, lon, head, pres 1262985487, 0, 0, 36.879405, -122.061562, 27.3, 27.75 1262985988, 0, 0, 36.879520, -122.060597, 70.9, 66.20 rovNav(): 008: 751 in tList after reading from \\tornado\TempNav\2010\vnta\nav2010008vnta.txt 751 in tList 751 in {self->{rovT}} 751 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1262985750 & 1262985600 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ......X.....................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................X... rovGDCListRefs(): dMedian = 70.2540003486611 rovGDCListRefs(): dStats->sample_range = 70.7097311303408 rovGDCListRefs(): returning (1st elements): 1262985370 36.799198 -122.108510 10.9 1.99512994484044 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 008 (looping to 008) Does file exist?: \\tornado\TempNav\2010\vnta\nav2010008vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2010\vnta\nav2010008vntaedited.txt esecs, east, north, lat, lon, head, pres 1262985487, 0, 0, 36.879394, -122.061578, 27.3, 27.75 1262985988, 0, 0, 36.879513, -122.060595, 70.9, 66.20 rovNav(): 008: 751 in tList after reading from \\tornado\TempNav\2010\vnta\nav2010008vntaedited.txt rovNav(): Initial # seconds to fill at beginning of dive = 776 starting at StartEsecs = 1262984594 rovNav(): Initial # seconds to fill at end of dive = 213 ending at EndEsecs =1262986664 rovNav(): LOGHOST_SYSTEM_UTC[0] = 1262984604 rovNav(): $LOGHOST_SYSTEM_UTC[end] = 1262986664 rovNav(): numMinBack = 11.75, numMinForward = 2.63333333333333 rovNav(): Refined StartEsecs = 1262984594, Refined EndEsecs = 1262986664 rovNav(): Refined # seconds to fill at beginning of dive = 776 starting at StartEsecs = 1262984594 rovNav(): Refined # seconds to fill at end of dive = 213 ending at EndEsecs =1262986664 rovNav(): num tList = 751 rovNav(): num eList = 751 rovNav(): Adding data to begining of dive from logr indices 0 .. 76 rovNav(): Adding data to end of dive from logr indices 185 .. 206 rovNav(): num in tList now = 850 rovNav(): num in eList now = 850 850 in tList 850 in {self->{rovT}} 850 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1262985750 & 1262985600 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXX.....X.....................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................X.......X rovGDCListRefs(): dMedian = 64.9155874365451 rovGDCListRefs(): dStats->sample_range = 77.7048611202581 rovGDCListRefs(): returning (1st elements): 1262984604 36.876128 -122.062065 292.1 -5 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.87938100 hash{lon} = -122.06127800 latMin = 30.879381 latMax = 42.879381 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.879381 AND 42.879381 AND Longitude BETWEEN -128.061278 AND -116.061278 Dive lat = 36.87938100, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.06127800 & lat = 36.87938100 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3484rov_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 = geo2010/vnta/vnta3484lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = ptlo shipNav(): $#{$self->{shipLat}} = 206 shipNav(): $#{$self->{shipLat}}[last] = 36.878732 Position subsampling set to 1 setROVcolorlines(): Assigning color line for Light... varColors = LightColors index0 = 0.2033 0.1827 0.0000 setROVcolorlines(): Assigning color line for O2... varColors = O2Colors index0 = 0 0 1 setROVcolorlines(): Assigning color line for Sal... varColors = SalColors index0 = 1.0000 1.0000 0.0364 setROVcolorlines(): Assigning color line for Temp... varColors = TempColors index0 = 0.6100 0.3900frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2010/008/accesses.txt at bin\geopdvc.pl line 2382 frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2010/008/accesses.txt at bin\geopdvc.pl line 625 0.0000 makeTracks(): n = 851 makeTracks(): Looping through 206 point of ship position data... makeTracks(): posSubsample = 1 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3484tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2010/vnta/vnta3484mergedCtdNav.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 '1/8/2010 9:15:09 PM' AND '1/8/2010 9:35:06 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '1/8/2010 9:15:09 PM' AND '1/8/2010 9:35:06 PM') _findIndex(): Looking for epoch secs 1262985638 ... Found time 1262985637 after 4 iterations. >>> p = 291: annotations(): 291, 1262985638, 01/08/10 21:20:38, V3484-01HD, 03:00:26:20, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3484/03_00_26_20.jpg, 72.0599975585938, cruise, MARS, o, 20040136 _findIndex(): Looking for epoch secs 1262985940 ... Found time 1262985943 after 5 iterations. >>> p = 597: annotations(): 597, 1262985940, 01/08/10 21:25:40, V3484-01HD, 03:05:28:29, physical object, , 70.5899963378906, cruise, MARS, o, 20040137 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3484anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Ancillary data = ["", "P: 72.5 db", "T: 11.775 C", "S: 33.422", "O: 4.114 ml/l", "L: 52.74 %"] inline_name = vnta3484anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical object Ancillary data = ["physical object", "P: 73.5 db", "T: 11.832 C", "S: 33.416", "O: 4.367 ml/l", "L: 62.38 %"] placeAnnotations(): Placing annotation 2: Ancillary data = ["", "P: 72.5 db", "T: 11.775 C", "S: 33.422", "O: 4.114 ml/l", "L: 52.74 %"] inline_name = vnta3484anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2010/vnta3484... frameGrabs(): matched 03_00_26_20 in [IMG]03_00_26_20.jpg20-Jan-2010 00:09 47K iList = 03_00_26_20.jpg _findIndex(): Looking for epoch secs 1262985638 ... Found time 1262985637 after 4 iterations. >>> p = 291: frameGrabs(): index = 291 EXPD::frameGrabs(): 291: Time=1262985630, Depth=72.94, Lat=36.879345, Lon=-122.061574, Pres=73.5, Temp=11.832, Sal=33.416, O2=4.367, Light=62.38 bin\geopdvc.pl: Number of images returned from expd->frameGrabs(every=>1)} = 1 bin\geopdvc.pl: Calling placeImages with every 10 image... placeImages(): Placing image 0 03_00_26_20.jpg 1262985638 fw= 0.0 cm XplaceImages(): indx = 291, geoPosition = 36.879345, -122.061574, -72.0301332527182, rovDepth = 72.0301332527182 bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 03_00_26_20.jpg 1262985638 fw= 0.0 cm XplaceImages(): indx = 291, geoPosition = 36.879345, -122.061574, -72.0301332527182, rovDepth = 72.0301332527182 bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 03_00_26_20.jpg 1262985638 fw= 0.0 cm XplaceImages(): indx = 291, geoPosition = 36.879345, -122.061574, -72.0301332527182, rovDepth = 72.0301332527182 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 '1/8/2010 9:15:09 PM' AND '1/8/2010 9:35:06 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2010/vnta/vnta3484.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',4250,'/3Dreplay/3D.asp?dives=vnta3484','vnta3484','','','',3484 Executing sql: UPDATE Dive SET DiveLatMid = 36.8794, DiveLonMid = -122.0613, DiveDepthMid = -64.9 WHERE RovName = 'vnta' AND DiveNumber = 3484