Running bin\geopdvc.pl at Thu Jul 7 03:00:34 2011 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3627 bin\geopdvc.pl: Getting Expedition object for diveno = 3627 and rname = vnta set_expd(): rov = vnta, diveno = 3627 set_expd(): $self->{EndDDD} = 129 set_expd(): $self->{StartEsecs} = 1304964000 set_expd(): $self->{EndEsecs} = 1304970900 set_expd(): $self->{EndDtg} = 5/9/2011 7:35:00 PM _readLogr(): Reading videologr data from 2011129datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1304964000 & 1304970900 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1304970905, self->{EndEsecs} = 1304970900 _readLogr(): #LOGHOST_SYSTEM_UTC = 689 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1304964003 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1304970895 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1304964003 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1304970895 refineStartAndEndEsecs(): setting StartEsecs to 1304964000 refineStartAndEndEsecs(): setting EndEsecs to 1304964033 refineStartAndEndEsecs(): numMinBack = 21.45, numMinForward = 0.9 refineStartAndEndEsecs(): Refined StartEsecs = 1304963913, Refined EndEsecs = 1304969754 _readLogr(): Reading videologr data from 2011129datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1304963913 & 1304969754 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1304969764, self->{EndEsecs} = 1304969754 _readLogr(): #LOGHOST_SYSTEM_UTC = 583 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1304963923 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1304969754 bin\geopdvc.pl: expdid = 4522 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 = 129 (looping to 129) Does file exist?: \\tornado\TempNav\2011\vnta\nav2011129vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2011\vnta\nav2011129vnta.txt esecs, east, north, lat, lon, head, pres 1304964108, 0, 0, 36.733637, -121.974535, 316.0, 7.98 1304964609, 0, 0, 36.732597, -121.973823, 228.4, 2.44 1304965531, 0, 0, 36.732370, -121.973975, 26.5, 86.60 1304966032, 0, 0, 36.732223, -121.974005, 337.3, 164.59 1304966533, 0, 0, 36.732252, -121.973987, 317.1, 164.41 1304967034, 0, 0, 36.732247, -121.973982, 313.9, 164.13 1304967535, 0, 0, 36.732303, -121.973895, 345.6, 159.72 1304968036, 0, 0, 36.732320, -121.973983, 335.3, 163.18 1304968537, 0, 0, 36.732648, -121.974302, 320.9, 83.50 1304969038, 0, 0, 36.732858, -121.974762, 320.5, 9.76 1304969539, 0, 0, 36.732323, -121.974590, 183.9, 2.45 rovNav(): 129: 5245 in tList after reading from \\tornado\TempNav\2011\vnta\nav2011129vnta.txt 5245 in tList 5245 in {self->{rovT}} 5245 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1304967645 & 1304967450 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 158.250245809306 rovGDCListRefs(): dStats->sample_range = 161.402696728641 rovGDCListRefs(): returning (1st elements): 1304963913 36.733697 -121.974602 315.5 59.4884947826762 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 129 (looping to 129) Does file exist?: \\tornado\TempNav\2011\vnta\nav2011129vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\tornado\TempNav\2011\vnta\nav2011129vntaedited.txt esecs, east, north, lat, lon, head, pres 1304964108, 0, 0, 36.733628, -121.974516, 316.0, 7.98 1304964609, 0, 0, 36.732572, -121.973845, 228.4, 2.44 1304965531, 0, 0, 36.732366, -121.973969, 26.5, 86.60 1304966032, 0, 0, 36.732228, -121.974024, 337.3, 164.59 1304966533, 0, 0, 36.732238, -121.973979, 317.1, 164.41 1304967034, 0, 0, 36.732277, -121.973996, 313.9, 164.13 1304967535, 0, 0, 36.732311, -121.973896, 345.6, 159.72 1304968036, 0, 0, 36.732338, -121.973990, 335.3, 163.18 1304968537, 0, 0, 36.732675, -121.974189, 320.9, 83.50 1304969038, 0, 0, 36.732825, -121.974772, 320.5, 9.76 1304969539, 0, 0, 36.738769, -121.980987, 183.9, 2.45 rovNav(): 129: 5245 in tList after reading from \\tornado\TempNav\2011\vnta\nav2011129vntaedited.txt rovNav(): Initial # seconds to fill at beginning of dive = 0 starting at StartEsecs = 1304963913 rovNav(): Initial # seconds to fill at end of dive = 145 ending at EndEsecs =1304969754 rovNav(): LOGHOST_SYSTEM_UTC[0] = 1304963923 rovNav(): $LOGHOST_SYSTEM_UTC[end] = 1304969754 rovNav(): numMinBack = 21.2833333333333, numMinForward = 0.9 rovNav(): Refined StartEsecs = 1304963913, Refined EndEsecs = 1304969754 rovNav(): Refined # seconds to fill at beginning of dive = 0 starting at StartEsecs = 1304963913 rovNav(): Refined # seconds to fill at end of dive = 145 ending at EndEsecs =1304969754 rovNav(): num tList = 5245 rovNav(): num eList = 5245 rovNav(): Adding data to begining of dive from logr indices 0 .. 0 rovNav(): Adding data to end of dive from logr indices 569 .. 583 rovNav(): num in tList now = 5261 rovNav(): num in eList now = 5261 5261 in tList 5261 in {self->{rovT}} 5261 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1304967645 & 1304967450 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXXXXXXX........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/129/accesses.txt at bin\geopdvc.pl line 2382 ...............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 158.190735137325 rovGDCListRefs(): dStats->sample_range = 168.397838934735 rovGDCListRefs(): returning (1st elements): 1304963923 36.731218 -121.971027 315.0 -5 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.73238200 hash{lon} = -121.97399200 latMin = 30.732382 latMax = 42.732382 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.732382 AND 42.732382 AND Longitude BETWEEN -127.973992 AND -115.973992 Dive lat = 36.73238200, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -121.97399200 & lat = 36.73238200 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3627rov_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/vnta3627lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = ptlo shipNav(): $#{$self->{shipLat}} = 583 shipNav(): $#{$self->{shipLat}}[last] = 36.731702 Position subsampling set to 5 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 = 5262 makeTracks(): Looping through 583 point of ship position data... makeTracks(): posSubsample = 5 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3627tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2011/vnta/vnta3627mergedCtdNav.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 ObservatioframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/129/accesses.txt at bin\geopdvc.pl line 625 nID FROM dbo.Annotations WHERE (ShipName = 'Point Lobos') AND (RecordedDate BETWEEN '5/9/2011 6:20:00 PM' AND '5/9/2011 7:35:00 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '5/9/2011 6:20:00 PM' AND '5/9/2011 7:35:00 PM') _findIndex(): Looking for epoch secs 1304966615 ... Found time 1304966618 after 7 iterations. >>> p = 2280: annotations(): 2280, 1304966615, 05/09/11 18:43:35, V3627-01HD, 03:43:06:10, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3627/03_43_06_10.jpg, 163.100006103516, descend, whpa, , 20046995 _findIndex(): Looking for epoch secs 1304966616 ... Found time 1304966618 after 7 iterations. >>> p = 2280: annotations(): 2280, 1304966616, 05/09/11 18:43:36, V3627-01HD, 03:43:08:25, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3627/03_43_08_25.jpg, 163.100006103516, descend, whpa, , 20046996 _findIndex(): Looking for epoch secs 1304966619 ... Found time 1304966618 after 7 iterations. >>> p = 2280: annotations(): 2280, 1304966619, 05/09/11 18:43:39, V3627-01HD, 03:43:10:10, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3627/03_43_10_10.jpg, 163.100006103516, descend, whpa, , 20046997 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3627anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 161.4 db", "T: 8.537 C", "S: 34.041", "O: 1.865 ml/l", "L: 85.78 %"] inline_name = vnta3627anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical object Ancillary data = ["physical object", "P: 161.4 db", "T: 8.537 C", "S: 34.041", "O: 1.865 ml/l", "L: 85.78 %"] placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 161.4 db", "T: 8.537 C", "S: 34.041", "O: 1.865 ml/l", "L: 85.78 %"] placeAnnotations(): Placing annotation 3: Ancillary data = ["", "P: 161.4 db", "T: 8.537 C", "S: 34.041", "O: 1.865 ml/l", "L: 85.78 %"] inline_name = vnta3627anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2011/vnta3627... frameGrabs(): matched 03_43_06_10 in [IMG]03_43_06_10.jpg25-Jun-2011 00:10 63K frameGrabs(): matched 03_43_08_25 in [IMG]03_43_08_25.jpg25-Jun-2011 00:10 63K frameGrabs(): matched 03_43_10_10 in [IMG]03_43_10_10.jpg25-Jun-2011 00:10 62K iList = 03_43_06_10.jpg 03_43_08_25.jpg 03_43_10_10.jpg _findIndex(): Looking for epoch secs 1304966615 ... Found time 1304966618 after 7 iterations. >>> p = 2280: frameGrabs(): index = 2280 EXPD::frameGrabs(): 2280: Time=1304966625, Depth=160.15, Lat=36.732243, Lon=-121.973976, Pres=161.4, Temp=8.537, Sal=34.041, O2=1.865, Light=85.78 _findIndex(): Looking for epoch secs 1304966616 ... Found time 1304966618 after 7 iterations. >>> p = 2280: frameGrabs(): index = 2280 EXPD::frameGrabs(): 2280: Time=1304966625, Depth=160.15, Lat=36.732243, Lon=-121.973976, Pres=161.4, Temp=8.537, Sal=34.041, O2=1.865, Light=85.78 _findIndex(): Looking for epoch secs 1304966619 ... Found time 1304966618 after 7 iterations. >>> p = 2280: frameGrabs(): index = 2280 EXPD::frameGrabs(): 2280: Time=1304966625, Depth=160.15, Lat=36.732243, Lon=-121.973976, Pres=161.4, Temp=8.537, Sal=34.041, O2=1.865, Light=85.78 bin\geopdvc.pl: Number of images returned from expd->frameGrabs(every=>1)} = 3 bin\geopdvc.pl: Calling placeImages with every 10 image... placeImages(): Placing image 0 03_43_06_10.jpg 1304966615 fw= 0.0 cm XplaceImages(): indx = 2280, geoPosition = 36.732243, -121.973976, -163.100293451301, rovDepth = 163.100293451301 inline_name = vnta3627fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 03_43_06_10.jpg 1304966615 fw= 0.0 cm XplaceImages(): indx = 2280, geoPosition = 36.732243, -121.973976, -163.100293451301, rovDepth = 163.100293451301 placeImages(): Placing image 2 03_43_10_10.jpg 1304966619 fw= 0.0 cm XplaceImages(): indx = 2280, geoPosition = 36.732243, -121.973976, -163.100293451301, rovDepth = 163.100293451301 inline_name = vnta3627fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 03_43_06_10.jpg 1304966615 fw= 0.0 cm XplaceImages(): indx = 2280, geoPosition = 36.732243, -121.973976, -163.100293451301, rovDepth = 163.100293451301 placeImages(): Placing image 1 03_43_08_25.jpg 1304966616 fw= 0.0 cm XplaceImages(): indx = 2280, geoPosition = 36.732243, -121.973976, -163.100293451301, rovDepth = 163.100293451301 placeImages(): Placing image 2 03_43_10_10.jpg 1304966619 fw= 0.0 cm XplaceImages(): indx = 2280, geoPosition = 36.732243, -121.973976, -163.100293451301, rovDepth = 163.100293451301 inline_name = vnta3627fg01.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 '5/9/2011 6:20:00 PM' AND '5/9/2011 7:35:00 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2011/vnta/vnta3627.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',4522,'/3Dreplay/3D.asp?dives=vnta3627','vnta3627','','','',3627 Executing sql: UPDATE Dive SET DiveLatMid = 36.7324, DiveLonMid = -121.9740, DiveDepthMid = -158.2 WHERE RovName = 'vnta' AND DiveNumber = 3627