Running bin\geopdvc.pl at Fri Sep 11 03:00:04 2015 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3844 bin\geopdvc.pl: Getting Expedition object for diveno = 3844 and rname = vnta set_expd(): rov = vnta, diveno = 3844 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 = 3844 AND RovName = 'vnta' RS->Fields(0)->Value= 5311 RS->Fields(1)->Value= 1436887020 RS->Fields(2)->Value= 1436892480 RS->Fields(3)->Value= 7/14/2015 3:17:00 PM RS->Fields(4)->Value= 7/14/2015 4:48:00 PM set_expd(): $self->{EndDDD} = 195 set_expd(): $self->{StartEsecs} = 1436885820 set_expd(): $self->{EndEsecs} = 1436893680 set_expd(): $self->{EndDtg} = 7/14/2015 4:48:00 PM _readLogr(): Reading videologr data from 2015195datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1436885820 & 1436893680 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1436893681, self->{EndEsecs} = 1436893680 _readLogr(): #LOGHOST_SYSTEM_UTC = 784 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1436885829 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1436893671 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1436885829 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1436893671 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1436885700, Refined EndEsecs = 1436893800 _readLogr(): Reading videologr data from 2015195datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1436885700 & 1436893800 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1436893801, self->{EndEsecs} = 1436893800 _readLogr(): #LOGHOST_SYSTEM_UTC = 808 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1436885709 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1436893791 bin\geopdvc.pl: expdid = 5311 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 = 195 (looping to 195) Does file exist?: \\atlas\RovNavEdit\2015\vnta\nav2015195vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2015\vnta\nav2015195vnta.txt esecs, east, north, lat, lon, head, pres 1436888070, 0, 0, 36.885783, -122.018655, 35.4, 50.68 1436888571, 0, 0, 36.885715, -122.015850, 75.3, 50.27 1436889071, 0, 0, 36.885700, -122.012563, 76.6, 49.21 1436889572, 0, 0, 36.885755, -122.009122, 82.0, 48.18 1436890073, 0, 0, 36.885647, -122.005260, 79.2, 46.98 1436890574, 0, 0, 36.885672, -122.003952, 328.3, 46.75 1436891075, 0, 0, 36.886168, -122.005278, 185.4, 46.62 1436891576, 0, 0, 36.885497, -122.003492, 88.3, 46.62 1436892340, 0, 0, 36.885417, -122.001330, 87.3, 3.70 rovNav(): 195: 4614 in tList after reading from \\atlas\RovNavEdit\2015\vnta\nav2015195vnta.txt 4614 in tList 4614 in {self->{rovT}} 4614 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are & rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): rovGDCListRefs(): dMedian = 46.8353625564934 rovGDCListRefs(): dStats->sample_range = 48.6905070915572 rovGDCListRefs(): returning (1st elements): 1436887570 36.885787 -122.018630 198.7 2.57081573276702 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 195 (looping to 195) Does file exist?: \\atlas\RovNavEdit\2015\vnta\nav2015195vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2015\vnta\nav2015195vntaedited.txt esecs, east, north, lat, lon, head, pres 1436888070, 0, 0, 36.885778, -122.018662, 35.4, 50.68 1436888frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/195/accesses.txt at bin\geopdvc.pl line 2382 571, 0, 0, 36.885719, -122.015851, 75.3, 50.27 1436889071, 0, 0, 36.885713, -122.012536, 76.6, 49.21 1436889572, 0, 0, 36.885736, -122.009100, 82.0, 48.18 1436890073, 0, 0, 36.885646, -122.005274, 79.2, 46.98 1436890574, 0, 0, 36.885690, -122.003954, 328.3, 46.75 1436891075, 0, 0, 36.886161, -122.005287, 185.4, 46.62 1436891576, 0, 0, 36.885515, -122.003376, 88.3, 46.62 1436892340, 0, 0, 36.884849, -122.000126, 87.3, 3.70 rovNav(): 195: 4614 in tList after reading from \\atlas\RovNavEdit\2015\vnta\nav2015195vntaedited.txt 4614 in tList 4614 in {self->{rovT}} 4614 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are & rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): rovGDCListRefs(): dMedian = 46.8353625523449 rovGDCListRefs(): dStats->sample_range = 48.6905069818854 rovGDCListRefs(): returning (1st elements): 1436887570 36.885287 -122.017393 198.7 2.57081584662513 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.88567000 hash{lon} = -122.00668200 latMin = 30.88567 latMax = 42.88567 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.88567 AND 42.88567 AND Longitude BETWEEN -128.006682 AND -116.006682 Dive lat = 36.88567000, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.00668200 & lat = 36.88567000 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3844rov_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 = geo2015/vnta/vnta3844lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 808 shipNav(): $#{$self->{shipLat}}[last] = 36.885340 Position subsampling set to 4 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 = 4615 makeTracks(): Looping through 808 point of ship position data... makeTracks(): posSubsample = 4 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3844tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2015/vnta/vnta3844mergedCtdNav.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/14/2015 3:17:00 PM' AND '7/14/2015 4:48:00 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '7/14/2015 3:17:00 PM' AND '7/14/2015 4:48:00 PM') _findIndex(): Looking for epoch secs 1436888630 ... Found time 1436888634 after 7 iterations. >frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/195/accesses.txt at bin\geopdvc.pl line 625 >> p = 1062: annotations(): 1062, 1436888630, 07/14/15 15:43:50, V3845-08HD, 05:27:31:08, physical object, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3845/05_27_31_08.jpg, 34.3600006103516, descend, whpa, u, 20057572 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3844anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... inline_name = vnta3844anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Ancillary data = ["", "P: db", "T: C", "S: ", "O: ml/l", "L: %"] inline_name = vnta3844anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2015/vnta3844... frameGrabs(): matched 00_00_13_24 in [IMG]00_00_13_24.jpg17-Jul-2015 10:22 1.4M frameGrabs(): matched 00_00_19_03 in [IMG]00_00_19_03.jpg17-Jul-2015 10:22 185K frameGrabs(): matched 00_45_36_06 in [IMG]00_45_36_06.jpg17-Jul-2015 10:22 170K iList = 00_00_13_24.jpg 00_00_19_03.jpg 00_45_36_06.jpg _findIndex(): Looking for epoch secs 1436887719 ... Found time 1436887714 after 4 iterations. >>> p = 144: frameGrabs(): index = 144 EXPD::frameGrabs(): 144: Time=, Depth=, Lat=36.885270, Lon=-122.017401, Pres=, Temp=, Sal=, O2=, Light= _findIndex(): Looking for epoch secs 1436887831 ... Found time 1436887831 after 8 iterations. >>> p = 261: frameGrabs(): index = 261 EXPD::frameGrabs(): 261: Time=, Depth=, Lat= 36.885387, Lon=-122.017813, Pres=, Temp=, Sal=, O2=, Light= _findIndex(): Looking for epoch secs 1436890581 ... Found time 1436890584 after 7 iterations. >>> p = 3009: frameGrabs(): index = 3009 EXPD::frameGrabs(): 3009: Time=, Depth=, Lat= 36.885701, Lon=-122.003949, Pres=, Temp=, Sal=, O2=, Light= 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 00_00_13_24.jpg 1436887719 fw= 0.0 cm placeImages(): indx = 144, geoPosition = 36.885270, -122.017401, -43.9773166032589, rovDepth = 43.9773166032589 inline_name = vnta3844fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 00_00_13_24.jpg 1436887719 fw= 0.0 cm placeImages(): indx = 144, geoPosition = 36.885270, -122.017401, -43.9773166032589, rovDepth = 43.9773166032589 placeImages(): Placing image 2 00_45_36_06.jpg 1436890581 fw= 0.0 cm placeImages(): indx = 3009, geoPosition = 36.885701, -122.003949, -46.1605492550192, rovDepth = 46.1605492550192 inline_name = vnta3844fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 00_00_13_24.jpg 1436887719 fw= 0.0 cm placeImages(): indx = 144, geoPosition = 36.885270, -122.017401, -43.9773166032589, rovDepth = 43.9773166032589 placeImages(): Placing image 1 00_00_19_03.jpg 1436887831 fw= 0.0 cm placeImages(): indx = 261, geoPosition = 36.885387, -122.017813, -45.366649834778, rovDepth = 45.366649834778 placeImages(): Placing image 2 00_45_36_06.jpg 1436890581 fw= 0.0 cm placeImages(): indx = 3009, geoPosition = 36.885701, -122.003949, -46.1605492550192, rovDepth = 46.1605492550192 inline_name = vnta3844fg01.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/14/2015 3:17:00 PM' AND '7/14/2015 4:48:00 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2015/vnta/vnta3844.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',5311,'/3Dreplay/3D.asp?dives=vnta3844','vnta3844','','','',3844 Executing sql: UPDATE Dive SET DiveLatMid = 36.8857, DiveLonMid = -122.0067, DiveDepthMid = -46.8 WHERE RovName = 'vnta' AND DiveNumber = 3844