Running bin\geopdvc.pl at Sun May 29 03:00:14 2011 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3615 bin\geopdvc.pl: Getting Expedition object for diveno = 3615 and rname = vnta set_expd(): rov = vnta, diveno = 3615 set_expd(): $self->{EndDDD} = 090 set_expd(): $self->{StartEsecs} = 1301590267 set_expd(): $self->{EndEsecs} = 1301595664 set_expd(): $self->{EndDtg} = 3/31/2011 6:01:04 PM _readLogr(): Reading videologr data from 2011090datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1301590267 & 1301595664 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1301595667, self->{EndEsecs} = 1301595664 _readLogr(): #LOGHOST_SYSTEM_UTC = 538 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1301590275 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1301595657 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1301590275 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1301595657 refineStartAndEndEsecs(): setting StartEsecs to 1301590267 refineStartAndEndEsecs(): setting EndEsecs to 1301590285 refineStartAndEndEsecs(): numMinBack = 21.7, numMinForward = 12.2 refineStartAndEndEsecs(): Refined StartEsecs = 1301590165, Refined EndEsecs = 1301595196 _readLogr(): Reading videologr data from 2011090datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1301590165 & 1301595196 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1301595206, self->{EndEsecs} = 1301595196 _readLogr(): #LOGHOST_SYSTEM_UTC = 502 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1301590175 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1301595196 bin\geopdvc.pl: expdid = 4499 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 = 090 (looping to 090) Does file exist?: \\tornado\TempNav\2011\vnta\nav2011090vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2011\vnta\nav2011090vnta.txt esecs, east, north, lat, lon, head, pres 1301591820, 0, 0, 36.750572, -122.107910, 126.1, 114.04 1301592321, 0, 0, 36.750355, -122.105395, 66.6, 244.99 1301592822, 0, 0, 36.751555, -122.105830, 324.5, 338.85 1301593323, 0, 0, 36.751417, -122.105953, 351.9, 328.38 1301593824, 0, 0, 36.750505, -122.107172, 233.9, 227.49 1301594325, 0, 0, 36.750745, -122.106248, 298.3, 52.23 rovNav(): 090: 3445 in tList after reading from \\tornado\TempNav\2011\vnta\nav2011090vnta.txt 3445 in tList 3445 in {self->{rovT}} 3445 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1301592750 & 1301594385 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): .............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 200.036886220542 rovGDCListRefs(): dStats->sample_range = 334.69807572481 rovGDCListRefs(): returning (1st elements): 1301591315 36.751412 -122.097633 43.9 2.05469444868231 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 090 (looping to 090) Does file exist?: \\tornado\TempNav\2011\vnta\nav2011090vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2011\vnta\nav2011090vntaedited.txt esecs, east, north, lat, lon, head, pres 1301591820, 0, 0, 36.750588, -122.107859, 126.1, 114.04 1301592321, 0, 0, 36.750352, -122.105441, 66.6, 244.99 1301592822, 0, 0, 36.751469, -122.105875, 324.5, 338.85 1301593323, 0, 0, 36.751400, -122.105940, 351.9, 328.38 1301593824, 0, 0, 36.750511, -122.107167, 233.9, 227.49 1301594325, 0, 0, 36.750740, -122.106257, 298.3, 52.23 rovNav(): 090: 3445 in tList after reading from \\tornado\TempNav\2011\vnta\nav2011090vntaedited.txt rovNav(): Initial # seconds to fill at beginning of dive = 1150 starting at StartEsecs = 1301590165 rovNav(): Initial # seconds to fill at end of dive = 408 ending at EndEsecs =1301595196 rovNav(): LOGHOST_SYSTEM_UTC[0] = 1301590175 rovNav(): $LOGHOST_SYSTEM_UTC[end] = 1301595196 rovNav(): numMinBack = 21.5333333333333, numMinForward = 12.2 rovNav(): Refined StartEsecs = 1301590165, Refined EndEsecs = 1301595196 rovNav(): Refined # seconds to fill at beginning of dive = 1150 starting at StartEsecs = 1301590165 rovNav(): Refined # seconds to fill at end of dive = 408 ending at EndEsecs =1301595196 rovNav(): num tList = 3445 rovNav(): num eList = 3445 rovNav(): Adding data to begining of dive from logr indices 0 .. 113 rovNav(): Adding data to end of dive from logr indices 462 .. 502 rovNav(): num in tList now = 3600 rovNav(): num in eList now = 3600 3600 in tList 3600 in {self->{rovT}} 3600 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1301592750 & 1301594385 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXX..........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 187.87410151951 rovGDCListRefs(): dStats->sample_range = 341.713065921287 rovGDCListRefs(): returning (1st elements): 1301590175 36.750340 -122.105540 49.2 -5 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.75072500 hash{lon} = -122.10620200 latMin = 30.750725 latMax = 42.750725 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.750725 AND 42.750725 AND Longitude BETWEEN -128.106202 AND -116.106202 Dive lat = 36.75072500, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.10620200 & lat = 36.75072500 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3615rov_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, cframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/090/accesses.txt at bin\geopdvc.pl line 2382 olor = 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/vnta3615lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = ptlo shipNav(): $#{$self->{shipLat}} = 502 shipNav(): $#{$self->{shipLat}}[last] = 36.749168 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 = 3601 makeTracks(): Looping through 502 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3615tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2011/vnta/vnta3615mergedCtdNav.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/31/2011 5:11:07 PM' AND '3/31/2011 6:01:04 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '3/31/2011 5:11:07 PM' AND '3/31/2011 6:01:04 PM') _findIndex(): Looking for epoch secs 1301592213 ... Found time 1301592213 after 8 iterations. >>> p = 1005: annotations(): 1005, 1301592213, 03/31/11 17:23:33, V3615-01HD, 00:11:55:02, Merlucciidae, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3615/00_11_55_02.jpg, 206.460006713867, descend, kwalz, , 20046337 _findIndex(): Looking for epoch secs 1301592737 ... Found time 1301592741 after 7 iterations. >>> p = 1532: annotations(): 1532, 1301592737, 03/31/11 17:32:17, V3615-01HD, 00:20:38:16, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3615/00_20_38_16.jpg, 335.600006103516, descend, kwalz, , 20046339 _findIndex(): Looking for epoch secs 1301592897 ... Found time 1301592896 after 4 iterations. >>> p = 1687: annotations(): 1687, 1301592897, 03/31/11 17:34:57, V3615-01HD, 00:23:18:26, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3615/00_23_18_26.jpg, 335.390014648438, descend, kwalz, , 20046340 _findIndex(): Looking for epoch secs 1301592973 ... Found time 1301592974 after 8 iterations. >>> p = 1764: annotations(): 1764, 1301592973, 03/31/11 17:36:13, V3615-01HD, 00:24:35:02, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3615/00_24_35_02.jpg, 336.149993896484, descend, kwalz, , 20046341 _findIndex(): Looking for epoch secs 1301592977 ... Found time 1301592981 after 6 iterations. >>> p = 1771: annotations(): 1771, 1301592977, 03/31/11 17:36:17, V3615-01HD, 00:24:39:03, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3615/00_24_39_03.jpg, 335.959991455078, descend, kwalz, , 20046342 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3615anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 335.8 db", "T: 7.236 C", "S: 34.194", "O: 0.705 ml/l", "L: 91.86 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data =frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/090/accesses.txt at bin\geopdvc.pl line 625 ["Midwater Respirometry System", "P: 336.2 db", "T: 7.267 C", "S: 34.193", "O: 0.708 ml/l", "L: 91.87 %"] inline_name = vnta3615anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 204.4 db", "T: 8.418 C", "S: 34.151", "O: 1.198 ml/l", "L: 91.76 %"] placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 335.8 db", "T: 7.236 C", "S: 34.194", "O: 0.705 ml/l", "L: 91.86 %"] placeAnnotations(): Placing annotation 3: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 335.4 db", "T: 7.271 C", "S: 34.193", "O: 0.714 ml/l", "L: 91.87 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 336.2 db", "T: 7.267 C", "S: 34.193", "O: 0.708 ml/l", "L: 91.87 %"] placeAnnotations(): Placing annotation 5: Ancillary data = ["", "P: 336.2 db", "T: 7.267 C", "S: 34.193", "O: 0.708 ml/l", "L: 91.87 %"] inline_name = vnta3615anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/vnta3615... frameGrabs(): matched 00_11_55_02 in [IMG]00_11_55_02.jpg08-Apr-2011 00:11 71K frameGrabs(): matched 00_20_38_16 in [IMG]00_20_38_16.jpg08-Apr-2011 00:11 74K frameGrabs(): matched 00_23_18_26 in [IMG]00_23_18_26.jpg08-Apr-2011 00:11 70K frameGrabs(): matched 00_24_35_02 in [IMG]00_24_35_02.jpg08-Apr-2011 00:11 111K frameGrabs(): matched 00_24_39_03 in [IMG]00_24_39_03.jpg08-Apr-2011 00:11 120K iList = 00_11_55_02.jpg 00_20_38_16.jpg 00_23_18_26.jpg 00_24_35_02.jpg 00_24_39_03.jpg _findIndex(): Looking for epoch secs 1301592213 ... Found time 1301592213 after 8 iterations. >>> p = 1005: frameGrabs(): index = 1005 EXPD::frameGrabs(): 1005: Time=1301592210, Depth=202.79, Lat=36.750277, Lon=-122.105733, Pres=204.4, Temp=8.418, Sal=34.151, O2=1.198, Light=91.76 _findIndex(): Looking for epoch secs 1301592737 ... Found time 1301592741 after 7 iterations. >>> p = 1532: frameGrabs(): index = 1532 EXPD::frameGrabs(): 1532: Time=1301592735, Depth=333.05, Lat= 36.751463, Lon=-122.105845, Pres=335.8, Temp=7.236, Sal=34.194, O2=0.705, Light=91.86 _findIndex(): Looking for epoch secs 1301592897 ... Found time 1301592896 after 4 iterations. >>> p = 1687: frameGrabs(): index = 1687 EXPD::frameGrabs(): 1687: Time=1301592900, Depth=332.66, Lat= 36.751525, Lon=-122.105861, Pres=335.4, Temp=7.271, Sal=34.193, O2=0.714, Light=91.87 _findIndex(): Looking for epoch secs 1301592973 ... Found time 1301592974 after 8 iterations. >>> p = 1764: frameGrabs(): index = 1764 EXPD::frameGrabs(): 1764: Time=1301592975, Depth=333.45, Lat=36.751492, Lon=-122.105926, Pres=336.2, Temp=7.267, Sal=34.193, O2=0.708, Light=91.87 _findIndex(): Looking for epoch secs 1301592977 ... Found time 1301592981 after 6 iterations. >>> p = 1771: frameGrabs(): index = 1771 EXPD::frameGrabs(): 1771: Time=1301592975, Depth=333.45, Lat= 36.751490, Lon=-122.105927, Pres=336.2, Temp=7.267, Sal=34.193, O2=0.708, Light=91.87 bin\geopdvc.pl: Number of images returned from expd->frameGrabs(every=>1)} = 5 bin\geopdvc.pl: Calling placeImages with every 10 image... placeImages(): Placing image 0 00_11_55_02.jpg 1301592213 fw= 0.0 cm XplaceImages(): indx = 1005, geoPosition = 36.750277, -122.105733, -206.348559173274, rovDepth = 206.348559173274 inline_name = vnta3615fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 00_11_55_02.jpg 1301592213 fw= 0.0 cm XplaceImages(): indx = 1005, geoPosition = 36.750277, -122.105733, -206.348559173274, rovDepth = 206.348559173274 placeImages(): Placing image 2 00_23_18_26.jpg 1301592897 fw= 0.0 cm XplaceImages(): indx = 1687, geoPosition = 36.751525, -122.105861, -335.167139411975, rovDepth = 335.167139411975 placeImages(): Placing image 4 00_24_39_03.jpg 1301592977 fw= 0.0 cm XplaceImages(): indx = 1771, geoPosition = 36.751490, -122.105927, -336.108570794008, rovDepth = 336.108570794008 inline_name = vnta3615fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 00_11_55_02.jpg 1301592213 fw= 0.0 cm XplaceImages(): indx = 1005, geoPosition = 36.750277, -122.105733, -206.348559173274, rovDepth = 206.348559173274 placeImages(): Placing image 1 00_20_38_16.jpg 1301592737 fw= 0.0 cm XplaceImages(): indx = 1532, geoPosition = 36.751463, -122.105845, -335.513984512835, rovDepth = 335.513984512835 placeImages(): Placing image 2 00_23_18_26.jpg 1301592897 fw= 0.0 cm XplaceImages(): indx = 1687, geoPosition = 36.751525, -122.105861, -335.167139411975, rovDepth = 335.167139411975 placeImages(): Placing image 3 00_24_35_02.jpg 1301592973 fw= 0.0 cm XplaceImages(): indx = 1764, geoPosition = 36.751492, -122.105926, -336.138300043353, rovDepth = 336.138300043353 placeImages(): Placing image 4 00_24_39_03.jpg 1301592977 fw= 0.0 cm XplaceImages(): indx = 1771, geoPosition = 36.751490, -122.105927, -336.108570794008, rovDepth = 336.108570794008 inline_name = vnta3615fg01.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 '3/31/2011 5:11:07 PM' AND '3/31/2011 6:01:04 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2011/vnta/vnta3615.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',4499,'/3Dreplay/3D.asp?dives=vnta3615','vnta3615','','','',3615 Executing sql: UPDATE Dive SET DiveLatMid = 36.7507, DiveLonMid = -122.1062, DiveDepthMid = -187.9 WHERE RovName = 'vnta' AND DiveNumber = 3615