Running bin\geopdvc.pl at Sat Nov 29 03:01:56 2014 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3805 bin\geopdvc.pl: Getting Expedition object for diveno = 3805 and rname = vnta set_expd(): rov = vnta, diveno = 3805 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 = 3805 AND RovName = 'vnta' RS->Fields(0)->Value= 5117 RS->Fields(1)->Value= 1412196330 RS->Fields(2)->Value= 1412200800 RS->Fields(3)->Value= 10/1/2014 8:45:30 PM RS->Fields(4)->Value= 10/1/2014 10:00:00 PM set_expd(): $self->{EndDDD} = 274 set_expd(): $self->{StartEsecs} = 1412195130 set_expd(): $self->{EndEsecs} = 1412202000 set_expd(): $self->{EndDtg} = 10/1/2014 10:00:00 PM _readLogr(): Reading videologr data from 2014274datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1412195130 & 1412202000 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1412202006, self->{EndEsecs} = 1412202000 _readLogr(): #LOGHOST_SYSTEM_UTC = 686 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1412195135 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1412201996 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1412195135 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1412201996 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1412195010, Refined EndEsecs = 1412202120 _readLogr(): Reading videologr data from 2014274datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1412195010 & 1412202120 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1412202126, self->{EndEsecs} = 1412202120 _readLogr(): #LOGHOST_SYSTEM_UTC = 710 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1412195015 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1412202116 bin\geopdvc.pl: expdid = 5117 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 = 274 (looping to 274) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014274vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014274vnta.txt esecs, east, north, lat, lon, head, pres 1412196154, 0, 0, 36.694473, -122.046248, 16.5, 3.62 1412196655, 0, 0, 36.748688, -122.100928, 329.0, 92.98 1412197155, 0, 0, 36.749505, -122.101908, 331.8, 206.48 1412197656, 0, 0, 36.749487, -122.102365, 10.0, 343.76 1412198157, 0, 0, 36.749455, -122.102245, 8.4, 399.86 1412198658, 0, 0, 36.750408, -122.102072, 114.5, 478.73 1412199159, 0, 0, 36.749103, -122.103493, 206.7, 466.73 1412199659, 0, 0, 36.748958, -122.103723, 257.4, 299.78 1412200160, 0, 0, 36.748530, -122.102702, 258.6, 146.99 1412200661, 0, 0, 36.747233, -122.101777, 321.1, 9.48 rovNav(): 274: 4988 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014274vnta.txt 4988 in tList 4988 in {self->{rovT}} 4988 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1412199900 & 1412198745 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): ........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 250.965993639343 rovGDCListRefs(): dStats->sample_range = 490.181339225857 rovGDCListRefs(): returning (1st elements): 1412195028 36.694473 -122.046248 322.0 2.49145096227092 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 274 (looping to 274) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014274vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014274vntaedited.txt esecs, east, north, lat, lon, head, pres 1412196154, 0, 0, 36.715249, -122.066446, 16.5, 3.62 1412196655, 0, 0, 36.748750, -122.101017, 329.0, 92.98 1412197155, 0, 0, 36.749542, -122.101894, 331.8, 206.48 1412197656, 0, 0, 36.749444, -122.102346, 10.0, 343.76 1412198157, 0, 0, 36.749456, -122.102263, 8.4, 399.86 1412198658, 0, 0, 36.750399, -122.102108, 114.5, 478.73 1412199159, 0, 0, 36.749100, -122.103503, 206.7, 466.73 1412199659, 0, 0, 36.748975, -122.103675, 257.4, 299.78 1412200160, 0, 0, 36.748495, -122.102752, 258.6, 146.99 1412200661, 0, 0, 36.747256, -122.101835, 321.1, 9.48 rovNav(): 274: 4988 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014274vntaedited.txt 4988 in tList 4988 in {self->{rovT}} 4988 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1412199900 & 1412198745 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXXXXXXXXXXXXXXXXXXX.......................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/274/accesses.txt at bin\geopdvc.pl line 2382 ....................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 250.965993372967 rovGDCListRefs(): dStats->sample_range = 490.181335430655 rovGDCListRefs(): returning (1st elements): 1412195028 36.708813 -122.059852 322.0 2.49144780364488 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.74908100 hash{lon} = -122.10223800 latMin = 30.749081 latMax = 42.749081 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.749081 AND 42.749081 AND Longitude BETWEEN -128.102238 AND -116.102238 Dive lat = 36.74908100, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.10223800 & lat = 36.74908100 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3805rov_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/vnta3805lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 710 shipNav(): $#{$self->{shipLat}}[last] = 36.756473 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 = 4989 makeTracks(): Looping through 710 point of ship position data... makeTracks(): posSubsample = 4 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3805tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2014/vnta/vnta3805mergedCtdNav.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 '10/1/2014 8:45:30 PM' AND '10/1/2014 10:00:00 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '10/1/2014 8:45:30 PM' AND '10/1/2014 10:00:00 PM') _findIndex(): Looking for epoch secs 1412198551 ... Found time 1412198553 after 7 iterations. >>> p = 2513: annotations(): 2513, 1412198551, 10/01/14 21:22:31, V3805-01HD, 00:39:23:10, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3805/00_39_23_10.jpg, 472.140014648438, endtransect, robs, u, 20056119 _findIndex(): Looking for epoch secs 1412198566 ... Found time 1412198562 after 8 iterations. >>> p = 2522: annotations(): 2522, 1412198566, 10/01/14 21:22:46, V3805-01HD, 00:39:37:24, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3805/00_39_37_24.jpg, 473.149993896484, endtransect, robs, u, 20056120 _findIndex(): Looking for epoch secs 1412198592 ... Found time 1412198591 after 7 iterations. >>> p = 2551: annotations(): 2551, 1412198592, 10/01/14 21:23:12, V3805-01HD, 00:40:03:23, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3805/00_40_03_23.jpg, 474.470001220703, endtransect, robs, u, 20056121 _findIndex(): Looking for epoch secs 1412198622 ... Found time 1412198620 after 8 iterations. >>> p = 2580: annotations(): 2580, 1412198622, 10/01/14 21:23:42, V3805-01HD, 00:40:34:07, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3805/00_40_34_07.jpg, 475.079986572266, endtransect, robs, u, 20056122 _findIndex(): Looking for epoch secs 1412198650 ... Found time 1412198650 after 6 iterations. >>> p = 2610: annotations(): 2610, 1412198650, 10/01/14 21:24:10, V3805-01HD, 00:41:02:09, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3805/00_41_02_09.jpg, 474.489990234375, endtransect, robs, u, 20056123 _findIndex(): Looking for epoch secs 1412198700 ... Found time 1412198698 after 8 iterations. >>> p = 2658: annotations(): 2658, 1412198700, 10/01/14 21:25:00, V3805-01HD, 00:41:52:07, Midwater Respirometry System, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3805/00_41_52_07.jpg, 474.980010986328, endtransect, robs, u, 20056124 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... inline_name = vnta3805anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 476.1 db", "T: 6.127 C", "S: 34.188", "O: 0.564 ml/l", "L: 87.94 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 477.7 db", "T: 6.121 C", "S: 34.188", "O: 0.565 ml/l", "L: 87.93 %"] placeAnnotations(): Placing annotation 6: Ancillary data = ["", "P: 477.6 db", "T: 6.113 C", "S: 34.189", "O: 0.563 ml/l", "L: 87.95 %"] inline_name = vnta3805anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 475.3 db", "T: 6.135 C", "S: 34.189", "O: 0.564 ml/l", "L: 87.92 %"] placeAnnotations(): Placing annotation 2: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 476.1 db", "T: 6.127 C", "S: 3frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/274/accesses.txt at bin\geopdvc.pl line 625 4.188", "O: 0.564 ml/l", "L: 87.94 %"] placeAnnotations(): Placing annotation 3: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 477.4 db", "T: 6.124 C", "S: 34.188", "O: 0.565 ml/l", "L: 87.96 %"] placeAnnotations(): Placing annotation 4: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 477.7 db", "T: 6.121 C", "S: 34.188", "O: 0.565 ml/l", "L: 87.93 %"] placeAnnotations(): Placing annotation 5: Midwater Respirometry System Ancillary data = ["Midwater Respirometry System", "P: 477.6 db", "T: 6.118 C", "S: 34.188", "O: 0.565 ml/l", "L: 87.77 %"] placeAnnotations(): Placing annotation 6: Ancillary data = ["", "P: 477.6 db", "T: 6.113 C", "S: 34.189", "O: 0.563 ml/l", "L: 87.95 %"] inline_name = vnta3805anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/vnta3805... frameGrabs(): matched 00_39_23_10 in [IMG]00_39_23_10.jpg11-Oct-2014 00:10 337K frameGrabs(): matched 00_39_37_24 in [IMG]00_39_37_24.jpg11-Oct-2014 00:10 333K frameGrabs(): matched 00_40_03_23 in [IMG]00_40_03_23.jpg11-Oct-2014 00:10 357K frameGrabs(): matched 00_40_34_07 in [IMG]00_40_34_07.jpg11-Oct-2014 00:10 526K frameGrabs(): matched 00_41_02_09 in [IMG]00_41_02_09.jpg11-Oct-2014 00:10 561K frameGrabs(): matched 00_41_52_07 in [IMG]00_41_52_07.jpg11-Oct-2014 00:10 521K iList = 00_39_23_10.jpg 00_39_37_24.jpg 00_40_03_23.jpg 00_40_34_07.jpg 00_41_02_09.jpg 00_41_52_07.jpg _findIndex(): Looking for epoch secs 1412198551 ... Found time 1412198553 after 7 iterations. >>> p = 2513: frameGrabs(): index = 2513 EXPD::frameGrabs(): 2513: Time=1412198550, Depth=471.25, Lat= 36.750281, Lon=-122.102173, Pres=475.3, Temp=6.135, Sal=34.189, O2=0.564, Light=87.92 _findIndex(): Looking for epoch secs 1412198566 ... Found time 1412198562 after 8 iterations. >>> p = 2522: frameGrabs(): index = 2522 EXPD::frameGrabs(): 2522: Time=1412198565, Depth=472.05, Lat= 36.750304, Lon=-122.102169, Pres=476.1, Temp=6.127, Sal=34.188, O2=0.564, Light=87.94 _findIndex(): Looking for epoch secs 1412198592 ... Found time 1412198591 after 7 iterations. >>> p = 2551: frameGrabs(): index = 2551 EXPD::frameGrabs(): 2551: Time=1412198595, Depth=473.33, Lat= 36.750358, Lon=-122.102149, Pres=477.4, Temp=6.124, Sal=34.188, O2=0.565, Light=87.96 _findIndex(): Looking for epoch secs 1412198622 ... Found time 1412198620 after 8 iterations. >>> p = 2580: frameGrabs(): index = 2580 EXPD::frameGrabs(): 2580: Time=1412198625, Depth=473.63, Lat=36.750351, Lon=-122.102162, Pres=477.7, Temp=6.121, Sal=34.188, O2=0.565, Light=87.93 _findIndex(): Looking for epoch secs 1412198650 ... Found time 1412198650 after 6 iterations. >>> p = 2610: frameGrabs(): index = 2610 EXPD::frameGrabs(): 2610: Time=1412198655, Depth=473.53, Lat= 36.750395, Lon=-122.102119, Pres=477.6, Temp=6.118, Sal=34.188, O2=0.565, Light=87.77 _findIndex(): Looking for epoch secs 1412198700 ... Found time 1412198698 after 8 iterations. >>> p = 2658: frameGrabs(): index = 2658 EXPD::frameGrabs(): 2658: Time=1412198700, Depth=473.53, Lat= 36.750400, Lon=-122.102109, Pres=477.6, Temp=6.113, Sal=34.189, O2=0.563, Light=87.95 bin\geopdvc.pl: Number of images returned from expd->frameGrabs(every=>1)} = 6 bin\geopdvc.pl: Calling placeImages with every 10 image... placeImages(): Placing image 0 00_39_23_10.jpg 1412198551 fw= 0.0 cm XplaceImages(): indx = 2513, geoPosition = 36.750281, -122.102173, -472.322700742617, rovDepth = 472.322700742617 inline_name = vnta3805fg10.wrl bin\geopdvc.pl: Calling placeImages with every 2 image... placeImages(): Placing image 0 00_39_23_10.jpg 1412198551 fw= 0.0 cm XplaceImages(): indx = 2513, geoPosition = 36.750281, -122.102173, -472.322700742617, rovDepth = 472.322700742617 placeImages(): Placing image 2 00_40_03_23.jpg 1412198592 fw= 0.0 cm XplaceImages(): indx = 2551, geoPosition = 36.750358, -122.102149, -474.471679066675, rovDepth = 474.471679066675 placeImages(): Placing image 4 00_41_02_09.jpg 1412198650 fw= 0.0 cm XplaceImages(): indx = 2610, geoPosition = 36.750395, -122.102119, -474.293421836128, rovDepth = 474.293421836128 inline_name = vnta3805fg02.wrl bin\geopdvc.pl: Calling placeImages with every 1 image... placeImages(): Placing image 0 00_39_23_10.jpg 1412198551 fw= 0.0 cm XplaceImages(): indx = 2513, geoPosition = 36.750281, -122.102173, -472.322700742617, rovDepth = 472.322700742617 placeImages(): Placing image 1 00_39_37_24.jpg 1412198566 fw= 0.0 cm XplaceImages(): indx = 2522, geoPosition = 36.750304, -122.102169, -473.065437882963, rovDepth = 473.065437882963 placeImages(): Placing image 2 00_40_03_23.jpg 1412198592 fw= 0.0 cm XplaceImages(): indx = 2551, geoPosition = 36.750358, -122.102149, -474.471679066675, rovDepth = 474.471679066675 placeImages(): Placing image 3 00_40_34_07.jpg 1412198622 fw= 0.0 cm XplaceImages(): indx = 2580, geoPosition = 36.750351, -122.102162, -475.075766898389, rovDepth = 475.075766898389 placeImages(): Placing image 4 00_41_02_09.jpg 1412198650 fw= 0.0 cm XplaceImages(): indx = 2610, geoPosition = 36.750395, -122.102119, -474.293421836128, rovDepth = 474.293421836128 placeImages(): Placing image 5 00_41_52_07.jpg 1412198700 fw= 0.0 cm XplaceImages(): indx = 2658, geoPosition = 36.750400, -122.102109, -474.956928087553, rovDepth = 474.956928087553 inline_name = vnta3805fg01.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 '10/1/2014 8:45:30 PM' AND '10/1/2014 10:00:00 PM') AND ROVName = 'Ventana' ORDER BY CollectionEventDTG bin\geopdvc.pl: World = geo2014/vnta/vnta3805.wrl Adding record to ExpeditionData table... Executing sql: exec insertExpeditionData '3Dreplay','','',5117,'/3Dreplay/3D.asp?dives=vnta3805','vnta3805','','','',3805 Executing sql: UPDATE Dive SET DiveLatMid = 36.7491, DiveLonMid = -122.1022, DiveDepthMid = -251.0 WHERE RovName = 'vnta' AND DiveNumber = 3805