Running bin\geopdvc.pl at Thu Sep 4 03:00:03 2014 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3790 bin\geopdvc.pl: Getting Expedition object for diveno = 3790 and rname = vnta set_expd(): rov = vnta, diveno = 3790 set_expd(): Executing sql: SELECT ExpeditionID_FK, DateDiff(ss, '01/01/70', DiveStartDtg), DateDiff(ss, '01/01/70', DiveEndDtg), DiveStartDtg, DiveEndDtg FROM Dive WHERE DiveNumber = 3790 AND RovName = 'vnta' RS->Fields(0)->Value= 5038 RS->Fields(1)->Value= 1404749438 RS->Fields(2)->Value= 1404751126 RS->Fields(3)->Value= 7/7/2014 4:10:38 PM RS->Fields(4)->Value= 7/7/2014 4:38:46 PM set_expd(): $self->{EndDDD} = 188 set_expd(): $self->{StartEsecs} = 1404748238 set_expd(): $self->{EndEsecs} = 1404752326 set_expd(): $self->{EndDtg} = 7/7/2014 4:38:46 PM _readLogr(): Reading videologr data from 2014188datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1404748238 & 1404752326 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1404752335, self->{EndEsecs} = 1404752326 _readLogr(): #LOGHOST_SYSTEM_UTC = 408 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1404748244 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1404752325 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1404748244 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1404752325 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1404748118, Refined EndEsecs = 1404752446 _readLogr(): Reading videologr data from 2014188datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1404748118 & 1404752446 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1404752455, self->{EndEsecs} = 1404752446 _readLogr(): #LOGHOST_SYSTEM_UTC = 432 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1404748124 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1404752445 bin\geopdvc.pl: expdid = 5038 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 = 188 (looping to 188) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014188vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014188vnta.txt esecs, east, north, lat, lon, head, pres 1404749765, 0, 0, 36.708158, -121.992728, 45.3, 72.84 1404750266, 0, 0, 36.708158, -121.992728, 126.5, 145.56 1404750766, 0, 0, 36.708158, -121.992728, 126.4, 120.59 1404751267, 0, 0, 36.708158, -121.992728, 49.7, 3.75 rovNav(): 188: 2090 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014188vnta.txt 2090 in tList 2090 in {self->{rovT}} 2090 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1404750000 & 1404750840 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ......................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 78.351843914269 rovGDCListRefs(): dStats->sample_range = 145.53281554563 rovGDCListRefs(): returning (1st elements): 1404749265 36.708158 -121.992728 36.7 2.70982041581328 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 188 (looping to 188) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014188vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014188vntaedited.txt esecs, east, north, lat, lon, head, pres 1404749765, 0, 0, 36.795796, -121.843555, 45.3, 72.84 1404750266, 0, 0, 36.795796, -121.843555, 126.5, 145.56 1404750766, 0, 0, 36.795796, -121.843555, 126.4, 120.59 1404751267, 0, 0, 36.795796, -121.843555, 49.7, 3.75 rovNav(): 188: 2090 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014188vntaedited.txt 2090 in tList 2090 in {self->{rovT}} 2090 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1404750000 & 1404750840 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXX............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 78.3512365334434 rovGDCListRefs(): dStats->sample_range = 145.531687389578 rovGDCListRefs(): returning (1st elements): 1404749265 36.795796 -121.843555 36.7 2.70979940919584 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.79579600 hash{lon} = -121.84355500 latMin = 30.795796 latMax = 42.795796 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.795796 AND 42.795796 AND Longitude BETWEEN -127.843555 AND -115.843555 frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/188/accesses.txt at bin\geopdvc.pl line 2382 Dive lat = 36.79579600, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -121.84355500 & lat = 36.79579600 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3790rov_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 = geo2014/vnta/vnta3790lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 432 shipNav(): $#{$self->{shipLat}}[last] = 36.699143 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 = 2091 makeTracks(): Looping through 432 point of ship position data... makeTracks(): posSubsample = 2 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3790tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2014/vnta/vnta3790mergedCtdNav.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 = '') AND (RecordedDate BETWEEN '7/7/2014 4:10:38 PM' AND '7/7/2014 4:38:46 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '7/7/2014 4:10:38 PM' AND '7/7/2014 4:38:46 PM') _findIndex(): Looking for epoch secs 1404749438 ... Found time 1404749443 after 6 iterations. >>> p = 178: annotations(): 178, 1404749438, 07/07/14 16:10:38, V3790-01HD, 00:00:47:00, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3790/00_00_47_00.jpg, 5.32999992370605, descend, lynne, u, 20055680 _findIndex(): Looking for epoch secs 1404749438 ... Found time 1404749443 after 6 iterations. >>> p = 178: annotations(): 178, 1404749438, 07/07/14 16:10:38, V3790-01HD, 00:00:55:00, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3790/00_00_55_00.jpg, 5.32999992370605, descend, lynne, u, 20055681 _findIndex(): Looking for epoch secs 1404749483 ... Found time 1404749484 after 7 iterations. >>> p = 219: annotations(): 219, 1404749483, 07/07/14 16:11:23, V3790-01HD, 00:02:35:04, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3790/00_02_35_04.jpg, 11.6999998092651, descend, lynne, u, 20055682 _findIndex(): Looking for epoch secs 1404749716 ... Found time 1404749712 after 7 iterations. >>> p = 447: annotations(): 447, 1404749716, 07/07/14 16:15:16, V3790-01HD, 00:06:28:10, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3790/00_06_28_10.jpg, 59.6500015258789, descend, lynne, u, 20055683 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3790anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/188/accesses.txt at bin\geopdvc.pl line 625 notations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: db", "T: C", "S: ", "O: ml/l", "L: %"] placeAnnotations(): Placing annotation 4: Ancillary data = ["", "P: 56.6 db", "T: 9.844 C", "S: 33.724", "O: 2.96 ml/l", "L: 87.19 %"] inline_name = vnta3790anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical object Ancillary data = ["physical object", "P: db", "T: C", "S: ", "O: ml/l", "L: %"] placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: db", "T: C", "S: ", "O: ml/l", "L: %"] placeAnnotations(): Placing annotation 3: physical object Ancillary data = ["physical object", "P: 8.7 db", "T: 13.113 C", "S: 33.712", "O: 6.439 ml/l", "L: 72.07 %"] placeAnnotations(): Placing annotation 4: Ancillary data = ["", "P: 56.6 db", "T: 9.844 C", "S: 33.724", "O: 2.96 ml/l", "L: 87.19 %"] inline_name = vnta3790anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/vnta3790... frameGrabs(): matched 00_00_47_00 in [IMG]00_00_47_00.jpg07-Jul-2014 09:09 140K frameGrabs(): matched 00_00_55_00 in [IMG]00_00_55_00.jpg10-Jul-2014 00:08 184K frameGrabs(): matched 00_02_35_04 in [IMG]00_02_35_04.jpg10-Jul-2014 00:08 201K frameGrabs(): matched 00_06_28_10 in [IMG]00_06_28_10.jpg10-Jul-2014 00:08 273K iList = 00_00_47_00.jpg 00_00_55_00.jpg 00_02_35_04.jpg 00_06_28_10.jpg _findIndex(): Looking for epoch secs 1404749438 ... Found time 1404749443 after 6 iterations. >>> p = 178: frameGrabs(): index = 178 EXPD::frameGrabs(): 178: Time=, Depth=, Lat=36.795796, Lon=-121.843555, Pres=, Temp=, Sal=, O2=, Light= _findIndex(): Looking for epoch secs 1404749438 ... Found time 1404749443 after 6 iterations. >>> p = 178: frameGrabs(): index = 178 EXPD::frameGrabs(): 178: Time=, Depth=, Lat=36.795796, Lon=-121.843555, Pres=, Temp=, Sal=, O2=, Light= _findIndex(): Looking for epoch secs 1404749483 ... Found time 1404749484 after 7 iterations. >>> p = 219: frameGrabs(): index = 219 EXPD::frameGrabs(): 219: Time=1404749490, Depth=8.64, Lat= 36.795796, Lon=-121.843555, Pres=8.7, Temp=13.113, Sal=33.712, O2=6.439, Light=72.07 _findIndex(): Looking for epoch secs 1404749716 ... Found time 1404749712 after 7 iterations. >>> p = 447: frameGrabs(): index = 447 EXPD::frameGrabs(): 447: Time=1404749715, Depth=56.18, Lat= 36.795796, Lon=-121.843555, Pres=56.6, Temp=9.844, Sal=33.724, O2=2.96, Light=87.19 bin\geopdvc.pl: Number of images returned from expd->frameGrabs(every=>1)} = 4 bin\geopdvc.pl: Calling placeImages with every 10 image... placeImages(): Placing image 0 00_00_47_00.jpg 1404749438 fw= 0.0 cm placeImages(): indx = 178, geoPosition = 36.795796, -121.843555, -6.68013622402806, rovDepth = 6.68013622402806 inline_name = vnta3790fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 00_00_47_00.jpg 1404749438 fw= 0.0 cm placeImages(): indx = 178, geoPosition = 36.795796, -121.843555, -6.68013622402806, rovDepth = 6.68013622402806 placeImages(): Placing image 2 00_02_35_04.jpg 1404749483 fw= 0.0 cm XplaceImages(): indx = 219, geoPosition = 36.795796, -121.843555, -11.7025011912317, rovDepth = 11.7025011912317 inline_name = vnta3790fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 00_00_47_00.jpg 1404749438 fw= 0.0 cm placeImages(): indx = 178, geoPosition = 36.795796, -121.843555, -6.68013622402806, rovDepth = 6.68013622402806 placeImages(): Placing image 1 00_00_55_00.jpg 1404749438 fw= 0.0 cm placeImages(): indx = 178, geoPosition = 36.795796, -121.843555, -6.68013622402806, rovDepth = 6.68013622402806 placeImages(): Placing image 2 00_02_35_04.jpg 1404749483 fw= 0.0 cm XplaceImages(): indx = 219, geoPosition = 36.795796, -121.843555, -11.7025011912317, rovDepth = 11.7025011912317 placeImages(): Placing image 3 00_06_28_10.jpg 1404749716 fw= 0.0 cm XplaceImages(): indx = 447, geoPosition = 36.795796, -121.843555, -57.6126805455703, rovDepth = 57.6126805455703 inline_name = vnta3790fg01.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 '7/7/2014 4:10:38 PM' AND '7/7/2014 4:38:46 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2014/vnta/vnta3790.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',5038,'/3Dreplay/3D.asp?dives=vnta3790','vnta3790','','','',3790 Executing sql: UPDATE Dive SET DiveLatMid = 36.7958, DiveLonMid = -121.8436, DiveDepthMid = -78.3 WHERE RovName = 'vnta' AND DiveNumber = 3790