Running bin\geopdvc.pl at Fri May 19 03:00:32 2017 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 4011 bin\geopdvc.pl: Getting Expedition object for diveno = 4011 and rname = vnta set_expd(): rov = vnta, diveno = 4011 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 = 4011 AND RovName = 'vnta' RS->Fields(0)->Value= 5839 RS->Fields(1)->Value= 1490132625 RS->Fields(2)->Value= 1490135955 RS->Fields(3)->Value= 3/21/2017 9:43:45 PM RS->Fields(4)->Value= 3/21/2017 10:39:15 PM set_expd(): $self->{EndDDD} = 080 set_expd(): $self->{StartEsecs} = 1490131425 set_expd(): $self->{EndEsecs} = 1490137155 set_expd(): $self->{EndDtg} = 3/21/2017 10:39:15 PM _readLogr(): Reading videologr data from 2017080datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1490131425 & 1490137155 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1490137161, self->{EndEsecs} = 1490137155 _readLogr(): #LOGHOST_SYSTEM_UTC = 572 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1490131430 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1490137151 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1490131430 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1490137151 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1490131305, Refined EndEsecs = 1490137275 _readLogr(): Reading videologr data from 2017080datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1490131305 & 1490137275 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1490137281, self->{EndEsecs} = 1490137275 _readLogr(): #LOGHOST_SYSTEM_UTC = 596 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1490131310 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1490137271 bin\geopdvc.pl: expdid = 5839 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 = 080 (looping to 080) Does file exist?: \\atlas\RovNavEdit\2017\vnta\nav2017080vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2017\vnta\nav2017080vnta.txt esecs, east, north, lat, lon, head, pres 1490133000, 0, 0, 36.787975, -121.903002, 296.3, 131.21 1490133501, 0, 0, 36.788327, -121.903120, 288.8, 312.44 1490134002, 0, 0, 36.788163, -121.903838, 176.6, 496.12 1490134503, 0, 0, 36.787463, -121.903817, 320.5, 519.65 1490135003, 0, 0, 36.788278, -121.905473, 317.2, 345.70 1490135504, 0, 0, 36.789218, -121.905792, 308.4, 162.56 rovNav(): 080: 3317 in tList after reading from \\atlas\RovNavEdit\2017\vnta\nav2017080vnta.txt 3317 in tList 3317 in {self->{rovT}} 3317 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1490135910 & 1490132655 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ..............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 300.677090219398 rovGDCListRefs(): dStats->sample_range = 527.140995767891 rovGDCListRefs(): returning (1st elements): 1490132632 36.787432 -121.902268 244.8 2.58076407152861 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 080 (looping to 080) Does file exist?: \\atlas\RovNavEdit\2017\vnta\nav2017080vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2017\vnta\nav2017080vntaedited.txt esecs, east, north, lat, lon, head, pres 1490133000, 0, 0, 36.787976, -121.903006, 296.3, 131.21 1490133501, 0, 0, 36.788322, -121.903142, 288.8, 312.44 1490134002, 0, 0, 36.788310, -121.903256, 176.6, 496.12 1490134503, 0, 0, 36.787477, -121.903838, 320.5, 519.65 1490135003, 0, 0, 36.788336, -121.905524, 317.2, 345.70 1490135504, 0, 0, 36.789226, -121.905785, 308.4, 162.56 rovNav(): 080: 3317 in tList after reading from \\atlas\RovNavEdit\2017\vnta\nav2017080vntaedited.txt 3317 in tList 3317 in {self->{rovT}} 3317 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1490135910 & 1490132655 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXXX.........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 300.677089580739 rovGDCListRefs(): dStats->sample_range = 527.140996585482 rovGDCListRefs(): returning (1st elements): 1490132632 36.787523 -121.902512 244.8 2.58076405074721 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.78822000 hash{lon} = -121.90338400 latMin = 30.78822 latMax = 42.78822 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.78822 AND 42.78822 AND Longitude BETWEEN -127.903384 AND -115.903384 Dive lat = 36.78822000, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -121.90338400 & lat = 36.78822000 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta4011rov_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, colorframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2017/080/accesses.txt at bin\geopdvc.pl line 2382 frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2017/080/accesses.txt at bin\geopdvc.pl line 625 = 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 = geo2017/vnta/vnta4011lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 596 shipNav(): $#{$self->{shipLat}}[last] = 36.789367 Position subsampling set to 3 setROVcolorlines(): Assigning color line for Light... varColors = LightColors index0 = 0.2333 0.2067 0.0000 setROVcolorlines(): Assigning color line for O2... varColors = O2Colors index0 = 0.0000 0.1947 0.8053 setROVcolorlines(): Assigning color line for Sal... varColors = SalColors index0 = 1.0000 0.9820 0.0000 setROVcolorlines(): Assigning color line for Temp... varColors = TempColors index0 = 0.0486 0.9514 0.0000 makeTracks(): n = 3318 makeTracks(): Looping through 596 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta4011tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2017/vnta/vnta4011mergedCtdNav.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 '3/21/2017 9:43:45 PM' AND '3/21/2017 10:39:15 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '3/21/2017 9:43:45 PM' AND '3/21/2017 10:39:15 PM') _findIndex(): Looking for epoch secs 1490134304 ... Found time 1490134305 after 7 iterations. >>> p = 1670: annotations(): 1670, 1490134304, 03/21/17 22:11:44, V4011-01HD, 02:51:15:21, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4011/02_51_15_21.jpg, 528.440002441406, descend, ventana, u, 20066384 _findIndex(): Looking for epoch secs 1490134338 ... Found time 1490134337 after 8 iterations. >>> p = 1702: annotations(): 1702, 1490134338, 03/21/17 22:12:18, V4011-01HD, 02:51:49:07, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4011/02_51_49_07.jpg, 529.669982910156, descend, ventana, u, 20066385 _findIndex(): Looking for epoch secs 1490134371 ... Found time 1490134370 after 6 iterations. >>> p = 1735: annotations(): 1735, 1490134371, 03/21/17 22:12:51, V4011-01HD, 02:52:22:09, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/4011/02_52_22_09.jpg, 529.710021972656, descend, ventana, u, 20066386 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta4011anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 536.1 db", "T: 6.169 C", "S: 34.234", "O: 0.62 ml/l", "L: 72.19 %"] inline_name = vnta4011anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: physical object Ancillary data = ["physical object", "P: 534.7 db", "T: 6.173 C", "S: 34.235", "O: 0.619 ml/l", "L: 71.94 %"] placeAnnotations(): Placing annotation 2: physical object Ancillary data = ["physical object", "P: 536.1 db", "T: 6.169 C", "S: 34.234", "O: 0.62 ml/l", "L: 72.19 %"] placeAnnotations(): Placing annotation 3: Ancillary data = ["", "P: 536.1 db", "T: 6.173 C", "S: 34.234", "O: 0.622 ml/l", "L: 72.69 %"] inline_name = vnta4011anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2017/vnta4011... frameGrabs(): matched 02_51_15_21 in [IMG]02_51_15_21.jpg 2017-03-28 00:34 255K  frameGrabs(): matched 02_51_49_07 in [IMG]02_51_49_07.jpg 2017-03-28 00:34 227K  frameGrabs(): matched 02_52_22_09 in [IMG]02_52_22_09.jpg 2017-03-28 00:34 267K  iList = 02_51_15_21.jpg 02_51_49_07.jpg 02_52_22_09.jpg _findIndex(): Looking for epoch secs 1490134304 ... Found time 1490134305 after 7 iterations. >>> p = 1670: frameGrabs(): index = 1670 EXPD::frameGrabs(): 1670: Time=1490134305, Depth=530.07, Lat= 36.787247, Lon=-121.903374, Pres=534.7, Temp=6.173, Sal=34.235, O2=0.619, Light=71.94 _findIndex(): Looking for epoch secs 1490134338 ... Found time 1490134337 after 8 iterations. >>> p = 1702: frameGrabs(): index = 1702 EXPD::frameGrabs(): 1702: Time=1490134335, Depth=531.46, Lat= 36.787238, Lon=-121.903369, Pres=536.1, Temp=6.169, Sal=34.234, O2=0.62, Light=72.19 _findIndex(): Looking for epoch secs 1490134371 ... Found time 1490134370 after 6 iterations. >>> p = 1735: frameGrabs(): index = 1735 EXPD::frameGrabs(): 1735: Time=1490134365, Depth=531.46, Lat= 36.787222, Lon=-121.903383, Pres=536.1, Temp=6.173, Sal=34.234, O2=0.622, Light=72.69 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 02_51_15_21.jpg 1490134304 fw= 0.0 cm XplaceImages(): indx = 1670, geoPosition = 36.787247, -121.903374, -528.424803540406, rovDepth = 528.424803540406 inline_name = vnta4011fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 02_51_15_21.jpg 1490134304 fw= 0.0 cm XplaceImages(): indx = 1670, geoPosition = 36.787247, -121.903374, -528.424803540406, rovDepth = 528.424803540406 placeImages(): Placing image 2 02_52_22_09.jpg 1490134371 fw= 0.0 cm XplaceImages(): indx = 1735, geoPosition = 36.787222, -121.903383, -529.682159004133, rovDepth = 529.682159004133 inline_name = vnta4011fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 02_51_15_21.jpg 1490134304 fw= 0.0 cm XplaceImages(): indx = 1670, geoPosition = 36.787247, -121.903374, -528.424803540406, rovDepth = 528.424803540406 placeImages(): Placing image 1 02_51_49_07.jpg 1490134338 fw= 0.0 cm XplaceImages(): indx = 1702, geoPosition = 36.787238, -121.903369, -529.672257856766, rovDepth = 529.672257856766 placeImages(): Placing image 2 02_52_22_09.jpg 1490134371 fw= 0.0 cm XplaceImages(): indx = 1735, geoPosition = 36.787222, -121.903383, -529.682159004133, rovDepth = 529.682159004133 inline_name = vnta4011fg01.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/21/2017 9:43:45 PM' AND '3/21/2017 10:39:15 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2017/vnta/vnta4011.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',5839,'/3Dreplay/3D.asp?dives=vnta4011','vnta4011','','','',4011 Executing sql: UPDATE Dive SET DiveLatMid = 36.7882, DiveLonMid = -121.9034, DiveDepthMid = -300.7 WHERE RovName = 'vnta' AND DiveNumber = 4011