Running bin\geopdvc.pl at Sun Sep 30 03:00:10 2007 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3056 bin\geopdvc.pl: Getting Expedition object for diveno = 3056 and rname = vnta set_expd(): rov = vnta, diveno = 3056 set_expd(): $self->{EndDDD} = 214 set_expd(): $self->{StartEsecs} = 1186066890 set_expd(): $self->{EndEsecs} = 1186071540 set_expd(): $self->{EndDtg} = 8/2/2007 3:59:00 PM _readLogr(): Reading videologr data from 2007214datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1186066890 & 1186071540 _readLogr(): Flushing variable names: _readLogr(): #LOGHOST_SYSTEM_UTC = 463 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1186066898 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1186071535 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1186066898 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1186071535 refineStartAndEndEsecs(): setting StartEsecs to 1186066890 refineStartAndEndEsecs(): setting EndEsecs to 1186067859 refineStartAndEndEsecs(): numMinBack = 5.85, numMinForward = 14.4 refineStartAndEndEsecs(): Refined StartEsecs = 1186067739, Refined EndEsecs = 1186071204 _readLogr(): Reading videologr data from 2007214datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1186067739 & 1186071204 _readLogr(): Flushing variable names: _readLogr(): #LOGHOST_SYSTEM_UTC = 345 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1186067749 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1186071204 bin\geopdvc.pl: expdid = 3699 Using raw Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 214 (looping to 214) rovNav(): Opening ROV nav data from \\tornado\TempNav\2007\vnta\nav2007214vnta.txt esecs, east, north, lat, lon, head, pres 1186068550, 0, 0, 36.715893, -121.909855, 235.4, 84.59 1186069056, 0, 0, 36.715762, -121.908655, 233.6, 86.78 1186069562, 0, 0, 36.715905, -121.908862, 243.2, 89.70 1186070068, 0, 0, 36.715905, -121.908862, 289.7, 53.56 214: 2339 in tList after reading from \\tornado\TempNav\2007\vnta\nav2007214vnta.txt rovNav(): Initial # seconds to fill at beginning of dive = 197 starting at StartEsecs = 1186067739 rovNav(): Initial # seconds to fill at end of dive = 692 ending at EndEsecs =1186071204 rovNav(): LOGHOST_SYSTEM_UTC[0] = 1186067749 rovNav(): $LOGHOST_SYSTEM_UTC[end] = 1186071204 rovNav(): numMinBack = 5.68333333333333, numMinForward = 14.4 rovNav(): Refined StartEsecs = 1186067739, Refined EndEsecs = 1186071204 rovNav(): Refined # seconds to fill at beginning of dive = 197 starting at StartEsecs = 1186067739 rovNav(): Refined # seconds to fill at end of dive = 692 ending at EndEsecs =1186071204 rovNav(): num tList = 2339 rovNav(): num eList = 2339 rovNav(): Adding data to begining of dive from logr indices 0 .. 18 rovNav(): Adding data to end of dive from logr indices 276 .. 345 rovNav(): num in tList now = 2428 rovNav(): num in eList now = 2428 2428 in tList 2428 in {self->{rovT}} 2428 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1186068090 & 1186070055 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): .......................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX 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 = 214 (looping to 214) rovNav(): Opening ROV nav data from \\tornado\TempNav\2007\vnta\nav2007214vnta.txt esecs, east, north, lat, lon, head, pres 1186068550, 0, 0, 36.715893, -121.909855, 235.4, 84.59 1186069056, 0, 0, 36.715762, -121.908655, 233.6, 86.78 1186069562, 0, 0, 36.715905, -121.908862, 243.2, 89.70 1186070068, 0, 0, 36.715905, -121.908862, 289.7, 53.56 214: 2339 in tList after reading from \\tornado\TempNav\2007\vnta\nav2007214vnta.txt 2339 in tList 2339 in {self->{rovT}} 2339 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1186068090 & 1186070055 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXX..........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................frameGrabs(): Can't get http://dods.mbari.org/data/frameGrabs/Ventana/stills/2007/214/accesses.txt at bin\geopdvc.pl line 2188 ...............................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.71590500 hash{lon} = -121.90886200 latMin = 30.715905 latMax = 42.715905 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.715905 AND 42.715905 AND Longitude BETWEEN -127.908862 AND -115.908862 Dive lat = 36.71590500, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -121.90886200 & lat = 36.71590500 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3056rov_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 = geo2007/vnta/vnta3056lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): $#{$self->{shipLat}} = 345 shipNav(): $#{$self->{shipLat}}[last] = 36.718330 Position subsampling set to 2 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 = 2429 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3056tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2007/vnta/vnta3056mergedCtdNav.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 '8/2/2007 3:21:30 PM' AND '8/2/2007 3:59:00 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '8/2/2007 3:21:30 PM' AND '8/2/2007 3:59:00 PM') _findIndex(): Looking for epoch secs 1186069242 ... Found time 1186069247 after 6 iterations. >>> p = 1187: annotations(): 1187, 1186069242, 08/02/07 15:40:42, V3056-01, 00:04:23:12, physical-object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_04_23_12.jpg, 89.0199966430664, descend, whpa, o, 20019899 _findIndex(): Looking for epoch secs 1186069244 ... Found time 1186069247 after 6 iterations. >>> p = 1187: annotations(): 1187, 1186069244, 08/02/07 15:40:44, V3056-01, 00:04:25:27, physical-object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_04_25_27.jpg, 88.9899978637695, descend, whpa, o, 20019900 _findIndex(): Looking for epoch secs 1186069245 ... Found time 1186069247 after 6 iterations. >>> p = 1187: annotations(): 1187, 1186069245, 08/02/07 15:40:45, V3056-01, 00:04:27:12, physical-object, http://searcframeGrabs(): Can't get http://dods.mbari.org/data/frameGrabs/Ventana/stills/2007/214/accesses.txt at bin\geopdvc.pl line 554 h.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_04_27_12.jpg, 88.9800033569336, descend, whpa, o, 20019901 _findIndex(): Looking for epoch secs 1186069514 ... Found time 1186069514 after 7 iterations. >>> p = 1451: annotations(): 1451, 1186069514, 08/02/07 15:45:14, V3056-01, 00:08:56:19, physical-object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_08_56_19.jpg, 89.0400009155273, descend, whpa, o, 20019902 _findIndex(): Looking for epoch secs 1186069629 ... Found time 1186069634 after 5 iterations. >>> p = 1570: annotations(): 1570, 1186069629, 08/02/07 15:47:09, V3056-01, 00:10:51:00, physical-object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_10_51_00.jpg, 89.0400009155273, descend, whpa, o, 20019903 _findIndex(): Looking for epoch secs 1186069638 ... Found time 1186069634 after 5 iterations. >>> p = 1570: annotations(): 1570, 1186069638, 08/02/07 15:47:18, V3056-01, 00:11:00:00, physical-object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_11_00_00.jpg, 89.0299987792969, descend, whpa, o, 20019904 _findIndex(): Looking for epoch secs 1186069730 ... Found time 1186069726 after 6 iterations. >>> p = 1661: annotations(): 1661, 1186069730, 08/02/07 15:48:50, V3056-01, 00:12:31:12, physical-object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_12_31_12.jpg, 89.0500030517578, descend, whpa, o, 20019905 _findIndex(): Looking for epoch secs 1186069820 ... Found time 1186069820 after 1 iterations. >>> p = 1754: annotations(): 1754, 1186069820, 08/02/07 15:50:20, V3056-01, 00:14:02:09, physical-object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3056/00_14_02_09.jpg, 89.0999984741211, descend, whpa, o, 20019906 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3056anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.5 C", "S: 33.918", "O: 2.78 ml/l", "L: 79.6 %"] placeAnnotations(): Placing annotation 4: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.487 C", "S: 33.921", "O: 2.78 ml/l", "L: 68.7 %"] placeAnnotations(): Placing annotation 6: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.487 C", "S: 33.919", "O: 2.78 ml/l", "L: 79.6 %"] placeAnnotations(): Placing annotation 8: Ancillary data = ["", "P: 87.7 db", "T: 9.496 C", "S: 33.92", "O: 2.79 ml/l", "L: 79.8 %"] inline_name = vnta3056anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.5 C", "S: 33.918", "O: 2.78 ml/l", "L: 79.6 %"] placeAnnotations(): Placing annotation 2: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.5 C", "S: 33.918", "O: 2.78 ml/l", "L: 79.6 %"] placeAnnotations(): Placing annotation 3: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.5 C", "S: 33.918", "O: 2.78 ml/l", "L: 79.6 %"] placeAnnotations(): Placing annotation 4: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.487 C", "S: 33.921", "O: 2.78 ml/l", "L: 68.7 %"] placeAnnotations(): Placing annotation 5: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.487 C", "S: 33.919", "O: 2.78 ml/l", "L: 79.6 %"] placeAnnotations(): Placing annotation 6: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.487 C", "S: 33.919", "O: 2.78 ml/l", "L: 79.6 %"] placeAnnotations(): Placing annotation 7: physical-object Ancillary data = ["physical-object", "P: 87.8 db", "T: 9.509 C", "S: 33.926", "O: 2.79 ml/l", "L: 80.7 %"] placeAnnotations(): Placing annotation 8: Ancillary data = ["", "P: 87.7 db", "T: 9.496 C", "S: 33.92", "O: 2.79 ml/l", "L: 79.8 %"] inline_name = vnta3056anno01.wrl frameGrabs(): Getting images from http://dods.mbari.org/data/frameGrabs/Ventana/stills/2007/vnta3056... frameGrabs(): matched 00_04_23_12 in [IMG] 00_04_23_12.jpg 06-Aug-2007 22:05 58k frameGrabs(): matched 00_04_25_27 in [IMG] 00_04_25_27.jpg 06-Aug-2007 22:05 58k frameGrabs(): matched 00_04_27_12 in [IMG] 00_04_27_12.jpg 06-Aug-2007 22:06 58k frameGrabs(): matched 00_08_56_19 in [IMG] 00_08_56_19.jpg 06-Aug-2007 22:06 60k frameGrabs(): matched 00_10_51_00 in [IMG] 00_10_51_00.jpg 06-Aug-2007 22:07 62k frameGrabs(): matched 00_11_00_00 in [IMG] 00_11_00_00.jpg 06-Aug-2007 22:08 62k frameGrabs(): matched 00_12_31_12 in [IMG] 00_12_31_12.jpg 06-Aug-2007 22:08 58k frameGrabs(): matched 00_14_02_09 in [IMG] 00_14_02_09.jpg 06-Aug-2007 22:09 67k iList = 00_04_23_12.jpg 00_04_25_27.jpg 00_04_27_12.jpg 00_08_56_19.jpg 00_10_51_00.jpg 00_11_00_00.jpg 00_12_31_12.jpg 00_14_02_09.jpg _findIndex(): Looking for epoch secs 1186069242 ... Found time 1186069247 after 6 iterations. >>> p = 1187: frameGrabs(): index = 1187 EXPD::frameGrabs(): 1187: Time=1186069245, Depth=87.2, Lat= 36.715905, Lon=-121.908862, Pres=87.8, Temp=9.5, Sal=33.918, O2=2.78, Light=79.6 _findIndex(): Looking for epoch secs 1186069244 ... Found time 1186069247 after 6 iterations. >>> p = 1187: frameGrabs(): index = 1187 EXPD::frameGrabs(): 1187: Time=1186069245, Depth=87.2, Lat= 36.715905, Lon=-121.908862, Pres=87.8, Temp=9.5, Sal=33.918, O2=2.78, Light=79.6 _findIndex(): Looking for epoch secs 1186069245 ... Found time 1186069247 after 6 iterations. >>> p = 1187: frameGrabs(): index = 1187 EXPD::frameGrabs(): 1187: Time=1186069245, Depth=87.2, Lat= 36.715905, Lon=-121.908862, Pres=87.8, Temp=9.5, Sal=33.918, O2=2.78, Light=79.6 _findIndex(): Looking for epoch secs 1186069514 ... Found time 1186069514 after 7 iterations. >>> p = 1451: frameGrabs(): index = 1451 EXPD::frameGrabs(): 1451: Time=1186069515, Depth=87.1, Lat= 36.715905, Lon=-121.908862, Pres=87.8, Temp=9.487, Sal=33.921, O2=2.78, Light=68.7 _findIndex(): Looking for epoch secs 1186069629 ... Found time 1186069634 after 5 iterations. >>> p = 1570: frameGrabs(): index = 1570 EXPD::frameGrabs(): 1570: Time=1186069635, Depth=87.1, Lat= 36.715905, Lon=-121.908862, Pres=87.8, Temp=9.487, Sal=33.919, O2=2.78, Light=79.6 _findIndex(): Looking for epoch secs 1186069638 ... Found time 1186069634 after 5 iterations. >>> p = 1570: frameGrabs(): index = 1570 EXPD::frameGrabs(): 1570: Time=1186069635, Depth=87.1, Lat= 36.715905, Lon=-121.908862, Pres=87.8, Temp=9.487, Sal=33.919, O2=2.78, Light=79.6 _findIndex(): Looking for epoch secs 1186069730 ... Found time 1186069726 after 6 iterations. >>> p = 1661: frameGrabs(): index = 1661 EXPD::frameGrabs(): 1661: Time=1186069725, Depth=87.1, Lat= 36.715905, Lon=-121.908862, Pres=87.8, Temp=9.509, Sal=33.926, O2=2.79, Light=80.7 _findIndex(): Looking for epoch secs 1186069820 ... Found time 1186069820 after 1 iterations. >>> p = 1754: frameGrabs(): index = 1754 EXPD::frameGrabs(): 1754: Time=1186069815, Depth=87, Lat= 36.715905, Lon=-121.908862, Pres=87.7, Temp=9.496, Sal=33.92, O2=2.79, Light=79.8 bin\geopdvc.pl: Calling placeImages with every 10 image... inline_name = vnta3056fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 2 00_04_27_12.jpg 1186069245 fw= 0.0 cm XplaceImages(): Placing image 4 00_10_51_00.jpg 1186069629 fw= 0.0 cm XplaceImages(): Placing image 6 00_12_31_12.jpg 1186069730 fw= 0.0 cm Xinline_name = vnta3056fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 1 00_04_25_27.jpg 1186069244 fw= 0.0 cm XplaceImages(): Placing image 2 00_04_27_12.jpg 1186069245 fw= 0.0 cm XplaceImages(): Placing image 3 00_08_56_19.jpg 1186069514 fw= 0.0 cm .placeImages(): Placing image 4 00_10_51_00.jpg 1186069629 fw= 0.0 cm .placeImages(): Placing image 5 00_11_00_00.jpg 1186069638 fw= 0.0 cm .placeImages(): Placing image 6 00_12_31_12.jpg 1186069730 fw= 0.0 cm .placeImages(): Placing image 7 00_14_02_09.jpg 1186069820 fw= 0.0 cm .inline_name = vnta3056fg01.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 '8/2/2007 3:21:30 PM' AND '8/2/2007 3:59:00 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2007/vnta/vnta3056.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',3699,'/3Dreplay/3D.asp?dives=vnta3056','vnta3056','','','',3056 Executing sql: UPDATE Dive SET DiveLatMid = 36.7159, DiveLonMid = -121.9089, DiveDepthMid = -86.2 WHERE RovName = 'vnta' AND DiveNumber = 3056