Running bin\geopdvc.pl at Fri Jan 9 03:00:17 2015 on host solstice Command line: bin\geopdvc.pl -rov vnta -dive 3816 bin\geopdvc.pl: Getting Expedition object for diveno = 3816 and rname = vnta set_expd(): rov = vnta, diveno = 3816 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 = 3816 AND RovName = 'vnta' RS->Fields(0)->Value= 5154 RS->Fields(1)->Value= 1415729736 RS->Fields(2)->Value= 1415731633 RS->Fields(3)->Value= 11/11/2014 6:15:36 PM RS->Fields(4)->Value= 11/11/2014 6:47:13 PM set_expd(): $self->{EndDDD} = 315 set_expd(): $self->{StartEsecs} = 1415728536 set_expd(): $self->{EndEsecs} = 1415732833 set_expd(): $self->{EndDtg} = 11/11/2014 6:47:13 PM _readLogr(): Reading videologr data from 2014315datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1415728536 & 1415732833 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1415732837, self->{EndEsecs} = 1415732833 _readLogr(): #LOGHOST_SYSTEM_UTC = 428 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1415728546 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1415732827 set_expd(): Calling _refineStartAndEndEsecs... refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 1415728546 refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 1415732827 refineStartAndEndEsecs(): numMinBack = 22, numMinForward = 22 refineStartAndEndEsecs(): Refined StartEsecs = 1415728416, Refined EndEsecs = 1415732953 _readLogr(): Reading videologr data from 2014315datavislogr.dat.gz. _readLogr(): Expedition start & stop times are 1415728416 & 1415732953 _readLogr(): Flushing variable names: _readLogr(): esecs of file line[0] = 1415732957, self->{EndEsecs} = 1415732953 _readLogr(): #LOGHOST_SYSTEM_UTC = 452 _readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 1415728426 _readLogr(): $LOGHOST_SYSTEM_UTC[end] = 1415732947 bin\geopdvc.pl: expdid = 5154 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 = 315 (looping to 315) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014315vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014315vnta.txt esecs, east, north, lat, lon, head, pres 1415728595, 0, 0, 36.788565, -122.059038, 198.9, 3.84 1415730003, 0, 0, 36.788470, -122.057358, 156.8, 122.56 1415730503, 0, 0, 36.787948, -122.056673, 2.7, 210.85 1415731004, 0, 0, 36.787993, -122.056642, 296.3, 206.09 1415731505, 0, 0, 36.788168, -122.057780, 172.8, 11.43 1415732777, 0, 0, 36.789733, -122.058425, 217.1, 3.88 rovNav(): 315: 2855 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014315vnta.txt 2855 in tList 2855 in {self->{rovT}} 2855 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1415730780 & 1415731515 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): .........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 74.2037449735002 rovGDCListRefs(): dStats->sample_range = 206.74195321993 rovGDCListRefs(): returning (1st elements): 1415728416 36.788565 -122.059038 166.1 3.61306016186556 geopdcv.pl(): editedNav flag = 1 Using mbnavedit edited Navigation. rovnavCTDO(): calcUTM = 0 rovNav(): 1, calcUTM = 0 rovNav(): calcUTM = 0 rovNav(): DDD = 315 (looping to 315) Does file exist?: \\atlas\RovNavEdit\2014\vnta\nav2014315vntaedited.txt yes. EXPD.pm: editNav flag = rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2014\vnta\nav2014315vntaedited.txt esecs, east, north, lat, lon, head, pres 1415728595, 0, 0, 36.788365, -122.058525, 198.9, 3.84 1415730003, 0, 0, 36.788433, -122.057344, 156.8, 122.56 1415730503, 0, 0, 36.787980, -122.056648, 2.7, 210.85 1415731004, 0, 0, 36.788002, -122.056628, 296.3, 206.09 1415731505, 0, 0, 36.788217, -122.057765, 172.8, 11.43 1415732777, 0, 0, 36.788200, -122.056861, 217.1, 3.88 rovNav(): 315: 2855 in tList after reading from \\atlas\RovNavEdit\2014\vnta\nav2014315vntaedited.txt 2855 in tList 2855 in {self->{rovT}} 2855 in {self->{rovH}} rovCTDO(): ROV CTDO start & stop times are 1415730780 & 1415731515 rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.): XXXXXXXXXXXX...............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................frameGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/315/accesses.txt at bin\geopdvc.pl line 2382 ..............................................................................................................XXXXXXXX rovGDCListRefs(): dMedian = 74.2037449538194 rovGDCListRefs(): dStats->sample_range = 206.74198465047 rovGDCListRefs(): returning (1st elements): 1415728416 36.788365 -122.058525 166.1 3.61306022580879 bin\geopdvc.pl: ------------------------------------------------------------------------------- hash{lat} = 36.78816400 hash{lon} = -122.05696700 latMin = 30.788164 latMax = 42.788164 Executing sql: SELECT Area, Latitude, Longitude FROM GeoOrigin WHERE Latitude BETWEEN 30.788164 AND 42.788164 AND Longitude BETWEEN -128.056967 AND -116.056967 Dive lat = 36.78816400, area = cencal bin\geopdvc.pl: Found area = cencal in GeoOrigin For midpoint lon = -122.05696700 & lat = 36.78816400 Using olon = -122 & olat = 36 bin\geopdvc.pl: Calling makeROVorig... inline_name = vnta3816rov_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/vnta3816lookup.wrl bin\geopdvc.pl: Getting ship nav... shipNav(): selecting for ShipName = rcsn shipNav(): WARNING: no match for ShipName = rcsn shipNav(): $#{$self->{shipLat}} = 452 shipNav(): $#{$self->{shipLat}}[last] = 36.788833 Position subsampling set to 3 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 = 2856 makeTracks(): Looping through 452 point of ship position data... makeTracks(): posSubsample = 3 makeTracks(): Writing tracks file... makeTracks(): INFO $sname = inline_name = vnta3816tracks.wrl writeCtdPosFile(): Writing merged CTD Nav data to geo2014/vnta/vnta3816mergedCtdNav.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 '11/11/2014 6:15:36 PM' AND '11/11/2014 6:47:13 PM') OR (RovName = 'Ventana') AND (RecordedDate BETWEEN '11/11/2014 6:15:36 PM' AND '11/11/2014 6:47:13 PM') _findIndex(): Looking for epoch secs 1415730364 ... Found time 1415730360 after 7 iterations. >>> p = 1036: annotations(): 1036, 1415730364, 11/11/14 18:26:04, V3816-01HD, 00:00:40:26, talus, , 207.600006103516, cruise, lonny, u, 4677795 _findIndex(): Looking for epoch secs 1415730365 ... Found time 1415730360 after 7 iterations. >>> p = 1036: annotations(): 1036, 1415730365, 11/11/14 18:26:05, V3816-01HD, 00:00:15:26, sunlit water, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_00_15_26.jpg, 207.600006103516, descend, lonny, u, 20056391 _findIndex(): Looking for epoch secs 1415730369 ... Found time 1415730371 after 6 iterations. >>> p = 1047: annotations(): 1047, 1415730369, 11/11/14 18:26:09, V3816-01HD, 00:00:46:16, Squalus suckleyi, , 208.039993286133, cruise, lonny, u, 4677791 _findIndex(): Looking for epoch secs 1415730368 ... Found time 1415730371 after 6 iterations. >>> p = 1047: annotations(): 1047, 1415730368, 11/11/14 18:26:08, V3816-01HD, 00:00:45:13, Florometra serratissima, , 208.039993286133, cruise, lonny, u, 4677796 _findIndex(): Looking for epoch secs 1415730372 ... Found time 1415730371 after 6 iterations. >>> p = 1047: annotations(): 1047, 1415730372, 11/11/14 18:26:12, V3816-01HD, 00:00:49:22, Parastichopus, , 208.130004882813, cruise, lonny, u, 4677797 _findIndex(): Looking for epoch secs 1415730365 ... Found time 1415730360 after 7 iterations. >>> p = 1036: annotations(): 1036, 1415730365, 11/11/14 18:26:05, V3816-01HD, 00:00:16:11, sunlit water, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_00_16_11.jpg, 207.600006103516, descend, lonny, u, 20056392 _findIndex(): Looking for epoch secs 1415730376 ... Found time 1415730371 after 6 iterations. >>> p = 1047: annotations(): 1047, 1415730376, 11/11/14 18:26:16, V3816-01HD, 00:00:53:15, asteroid feeding depression, , 207.809997558594, cruise, lonny, u, 4677792 _findIndex(): Looking for epoch secs 1415730379 ... Found time 1415730382 after 7 iterations. >>> p = 1058: annotations(): 1058, 1415730379, 11/11/14 18:26:19, V3816-01HD, 00:00:56:01, Strongylocentrotus fragilis, , 207.630004882813, cruise, lonny, u, 4677793 _findIndex(): Looking for epoch secs 1415730385 ... Found time 1415730382 after 7 iterations. >>> p = 1058: annotations(): 1058, 1415730385, 11/11/14 18:26:25, V3816-01HD, 00:01:02:11, Praya, , 206.729995727539, cruise, lonny, u, 4677794 _findIndex(): Looking for epoch secs 1415730399 ... Found time 1415730394 after 2 iterations. >>> p = 1070: annotations(): 1070, 1415730399, 11/11/14 18:26:39, V3816-01HD, 00:01:16:02, Hydrolagus colliei, , 206.860000610352, cruise, lonny, u, 4677798 _findIndex(): Looking for epoch secs 1415730419 ... Found time 1415730416 after 6 iterations. >>> p = 1092: annotations(): 1092, 1415730419, 11/11/14 18:26:59, V3816-01HD, 00:02:06:28, Stylasterias forreri, , 206.669998168945, cruise, lonny, u, 4677799 _findIndex(): Looking for epoch secs 1415730450 ... Found time 1415730449 after 7 iterations. >>> p = 1125: annotations(): 1125, 1415730450, 11/11/14 18:27:30, V3816-01HD, 00:02:17:24, Squalus suckleyi, , 207.649993896484, cruise, lonny, u, 4677800 _findIndex(): Looking for epoch secs 1415730461 ... Found time 1415730460 after 6 iterations. >>> p = 1136: annotations(): 1136, 1415730461, 11/11/14 18:27:41, V3816-01HD, 00:02:42:28, Sebastes elongatus, , 208.279998779297, cruise, lonny, u, 4677801 _findIndex(): Looking for epoch secs 1415730372 ... Found time 1415730371 after 6 iterations. >>> p = 1047: annotations(): 1047, 1415730372, 11/11/14 18:26:12, V3816-01HD, 00:00:50:00, Strongylocentrotus fragilis, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_00_50_00.jpg, 208.130004882813, cruise, lonny, u, 20056393 _findIndex(): Looking for epoch secs 1415730484 ... Found time 1415730483 after 4 iterations. >>> p = 1159: annotations(): 1159, 1415730484, 11/11/14 18:28:04, V3816-01HD, 00:02:42:01, Stylasterias forreri, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_02_42_01.jpg, 209.199996948242, cruise, lonny, u, 20056394 _findIndex(): Looking for epoch secs 1415730526 ... Found time 1415730527 after 5 iterations. >>> p = 1203: annotations(): 1203, 1415730526, 11/11/14 18:28:46, V3816-01HD, 00:03:23:17, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_03_23_17.jpg, 209.160003662109, cruise, lonny, u, 20056395 _findIndex(): Looking for epoch secs 1415730542 ... Found time 1415730538 after 7 iterations. >>> p = 1214: annotations(): 1214, 1415730542, 11/11/14 18:29:02, V3816-01HD, 00:03:39:16, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_03_39_16.jpg, 209.179992675781, cruise, lonny, u, 20056396 _findIndex(): Looking for epoch secs 1415730546 ... Found time 1415730549 after 6 iterations. >>> p = 1225: annotations(): 1225, 1415730546, 11/11/14 18:29:06, V3816-01HD, 00:03:44:01, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_03_44_01.jpg, 209.169998168945, cruise, lonny, u, 20056397 _findIndex(): Looking for epoch secs 1415730562 ... Found time 1415730560 after 7 iterations. >>> p = 1236: annotations(): 1236, 1415730562, 11/11/14 18:29:22, V3816-01HD, 00:04:00:03, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_04_00_03.jpg, 209.139999389648, cruise, lonny, u, 20056398 _findIndex(): Looking for epoch secs 1415730580 ... Found time 1415730584 after 7 iterations. >>> p = 1259: annotations(): 1259, 1415730580, 11/11/14 18:29:40, V3816-01HD, 00:04:17:17, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_04_17_17.jpg, 209.149993896484, cruise, lonny, u, 20056399 _findIndex(): Looking for epoch secs 1415730594 ... Found time 1415730595 after 6 iterations. >>> p = 1270: annotations(): 1270, 1415730594, 11/11/14 18:29:54, V3816-01HD, 00:04:31:17, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_04_31_17.jpg, 209.149993896484, cruise, lonny, u, 20056400 _findIndex(): Looking for epoch secs 1415730669 ... Found time 1415730673 after 7 iterations. >>> p = 1348: annotations(): 1348, 1415730669, 11/11/14 18:31:09, V3816-01HD, 00:05:47:02, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_05_47_02.jpg, 208.410003662109, cruise, lonny, u, 20056401 _findIndex(): Looking for epoch secs 1415730681 ... Found time 1415730684 after 6 iterations. >>> p = 1359: annotations(): 1359, 1415730681, 11/11/14 18:31:21, V3816-01HD, 00:05:59:02, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_05_59_02.jpg, 208.669998168945, cruise, lonny, u, 20056402 _findIndex(): Looking for epoch secs 1415730689 ... Found time 1415730684 after 6 iterations. >>> p = 1359: annotations(): 1359, 1415730689, 11/11/14 18:31:29, V3816-01HD, 00:06:07:04, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_06_07_04.jpg, 208.75, cruise, lonny, u, 20056403 _findIndex(): Looking for epoch secs 1415730720 ... Found time 1415730718 after 7 iterations. >>> p = 1393: annotations(): 1393, 1415730720, 11/11/14 18:32:00, V3816-01HD, 00:06:37:18, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_06_37_18.jpg, 208.800003051758, cruise, lonny, u, 20056404 _findIndex(): Looking for epoch secs 1415730761 ... Found time 1415730763 after 7 iterations. >>> p = 1438: annotations(): 1438, 1415730761, 11/11/14 18:32:41, V3816-01HD, 00:07:19:03, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_07_19_03.jpg, 208.800003051758, cruise, lonny, u, 20056405 _findIndex(): Looking for epoch secs 1415730877 ... Found time 1415730874 after 7 iterations. >>> p = 1549: annotations(): 1549, 1415730877, 11/11/14 18:34:37, V3816-01HD, 00:09:14:20, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_09_14_20.jpg, 208.779998779297, cruise, lonny, u, 20056406 _findIndex(): Looking for epoch secs 1415730879 ... Found time 1415730874 after 7 iterations. >>> p = 1549: annotations(): 1549, 1415730879, 11/11/14 18:34:39, V3816-01HD, 00:09:17:05, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_09_17_05.jpg, 208.759994506836, cruise, lonny, u, 20056407 _findIndex(): Looking for epoch secs 1415730896 ... Found time 1415730896 after 7 iterations. >>> p = 1571: annotations(): 1571, 1415730896, 11/11/14 18:34:56, V3816-01HD, 00:09:34:04, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_09_34_04.jpg, 208.539993286133, cruise, lonny, u, 20056408 _findIndex(): Looking for epoch secs 1415730903 ... Found time 1415730907 after 6 iterations. >>> p = 1582: annotations(): 1582, 1415730903, 11/11/14 18:35:03, V3816-01HD, 00:09:41:04, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_09_41_04.jpg, 208.539993286133, cruise, lonny, u, 20056409 _findIndex(): Looking for epoch secs 1415731006 ... Found time 1415731007 after 7 iterations. >>> p = 1682: annotations(): 1682, 1415731006, 11/11/14 18:36:46, V3816-01HD, 00:11:22:28, Doryteuthis opalescens, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_11_22_28.jpg, 204.220001220703, ascend, lonny, u, 4677802 _findIndex(): Looking for epoch secs 1415731020 ... Found time 1415731019 after 4 iterations. >>> p = 1694: annotations(): 1694, 1415731020, 11/11/14 18:37:00, V3816-01HD, 00:11:37:26, Doryteuthis opalescens, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_11_37_26.jpg, 204.039993286133, ascend, lonny, u, 4677803 _findIndex(): Looking for epoch secs 1415731043 ... Found time 1415731041 after 6 iterations. >>> p = 1716: annotations(): 1716, 1415731043, 11/11/14 18:37:23, V3816-01HD, 00:12:14:10, ink, , 196.600006103516, ascend, lonny, u, 4677804 _findIndex(): Looking for epoch secs 1415731154 ... Found time 1415731153 after 5 iterations. >>> p = 1828: annotations(): 1828, 1415731154, 11/11/14 18:39:14, V3816-01HD, 00:13:51:27, larvacean house, , 165.669998168945, ascend, lonny, u, 4677806 _findIndex(): Looking for epoch secs 1415731245 ... Found time 1415731243 after 5 iterations. >>> p = 1917: annotations(): 1917, 1415731245, 11/11/14 18:40:45, V3816-01HD, 00:15:22:11, Nanomia bijuga, , 114.870002746582, ascend, lonny, u, 4677807 _findIndex(): Looking for epoch secs 1415731248 ... Found time 1415731243 after 5 iterations. >>> p = 1917: annotations(): 1917, 1415731248, 11/11/14 18:40:48, V3816-01HD, 00:15:25:16, Mitrocoma cellularia, , 112.940002441406, ascend, lonny, u, 4677808 _findIndex(): Looking for epoch secs 1415731258 ... Found time 1415731254 after 7 iterations. >>> p = 1928: annotations(): 1928, 1415731258, 11/11/14 18:40:58, V3816-01HD, 00:16:56:11, Doryteuthis opalescens, , 107.779998779297, ascend, lonny, u, 4677809 _findIndex(): Looking for epoch secs 1415731339 ... Found time 1415731343 after 7 iterations. >>> p = 2017: annotations(): 2017, 1415731339, 11/11/14 18:42:19, V3816-01HD, 00:18:01:28, sunlit water, , 74.4000015258789, ascend, lonny, u, 4677810 _findIndex(): Looking for epoch secs 1415731405 ... Found time 1415731410 after 7 iterations. >>> p = 2084: annotations(): 2084, 1415731405, 11/11/14 18:43:25, V3816-01HD, 00:19:10:06, Mitrocoma cellularia, , 44.6800003051758, ascend, lonny, u, 4677811 _findIndex(): Looking for epoch secs 1415730908 ... Found time 1415730907 after 6 iterations. >>> p = 1582: annotations(): 1582, 1415730908, 11/11/14 18:35:08, V3816-01HD, 00:09:46:04, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_09_46_04.jpg, 208.210006713867, cruise, lonny, u, 20056410 _findIndex(): Looking for epoch secs 1415730916 ... Found time 1415730918 after 7 iterations. >>> p = 1593: annotations(): 1593, 1415730916, 11/11/14 18:35:16, V3816-01HD, 00:09:54:04, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_09_54_04.jpg, 207.75, cruise, lonny, u, 20056411 _findIndex(): Looking for epoch secs 1415730921 ... Found time 1415730918 after 7 iterations. >>> p = 1593: annotations(): 1593, 1415730921, 11/11/14 18:35:21, V3816-01HD, 00:09:59:04, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_09_59_04.jpg, 207.539993286133, cruise, lonny, u, 20056412 _findIndex(): Looking for epoch secs 1415730936 ... Found time 1415730941 after 7 iterations. >>> p = 1616: annotations(): 1616, 1415730936, 11/11/14 18:35:36, V3816-01HD, 00:10:14:18, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_10_14_18.jpg, 207.479995727539, cruise, lonny, u, 20056413 _findIndex(): Looking for epoch secs 1415730950 ... Found time 1415730952 after 6 iterations. >>> p = 1627: annotations(): 1627, 1415730950, 11/11/14 18:35:50, V3816-01HD, 00:10:28:03, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_10_28_03.jpg, 207.559997558594, cruise, lonny, u, 20056414 _findIndex(): Looking for epoch secs 1415730971 ... Found time 1415730974 after 5 iterations. >>> p = 1649: annotations(): 1649, 1415730971, 11/11/14 18:36:11, V3816-01HD, 00:10:49:17, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_10_49_17.jpg, 207.690002441406, cruise, lonny, u, 20056415 _findIndex(): Looking for epoch secs 1415730987 ... Found time 1415730985 after 7 iterations. >>> p = 1660: annotations(): 1660, 1415730987, 11/11/14 18:36:27, V3816-01HD, 00:11:04:19, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_11_04_19.jpg, 206.839996337891, cruise, lonny, u, 20056416 _findIndex(): Looking for epoch secs 1415730992 ... Found time 1415730996 after 6 iterations. >>> p = 1671: annotations(): 1671, 1415730992, 11/11/14 18:36:32, V3816-01HD, 00:11:09:19, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_11_09_19.jpg, 206.240005493164, cruise, lonny, u, 20056417 _findIndex(): Looking for epoch secs 1415731001 ... Found time 1415730996 after 6 iterations. >>> p = 1671: annotations(): 1671, 1415731001, 11/11/14 18:36:41, V3816-01HD, 00:11:19:04, equipment, http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/images/3816/00_11_19_04.jpg, 204.970001220703, cruise, lonny, u, 20056418 bin\geopdvc.pl: Calling placeAnnotations with every 10 annotation... placeAnnotations(): Placing annotation 10: Stylasterias forreri Ancillary data = ["Stylasterias forreri", "P: 207.5 db", "T: 9.036 C", "S: 33.963", "O: 2.066 ml/l", "L: 86.68 %"] placeAnnotations(): Placing annotation 20: equipment Ancillary data = ["equipment", "P: 209.9 db", "T: 9.021 C", "S: 33.966", "O: 2.038 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 30: Doryteuthis opalescens Ancillary data = ["Doryteuthis opalescens", "P: 209 db", "T: 9 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.33 %"] placeAnnotations(): Placing annotation 40: equipment Ancillary data = ["equipment", "P: 209 db", "T: 9 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.33 %"] inline_name = vnta3816anno10.wrl bin\geopdvc.pl: Calling placeAnnotations with every 2 annotation... placeAnnotations(): Placing annotation 2: Squalus suckleyi Ancillary data = ["Squalus suckleyi", "P: 208.4 db", "T: 9.034 C", "S: 33.965", "O: 2.066 ml/l", "L: 86.7 %"] placeAnnotations(): Placing annotation 4: Parastichopus Ancillary data = ["Parastichopus", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 6: asteroid feeding depression Ancillary data = ["asteroid feeding depression", "P: 208.4 db", "T: 9.034 C", "S: 33.965", "O: 2.066 ml/l", "L: 86.7 %"] placeAnnotations(): Placing annotation 8: Praya Ancillary data = ["Praya", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 10: Stylasterias forreri Ancillary data = ["Stylasterias forreri", "P: 207.5 db", "T: 9.036 C", "S: 33.963", "O: 2.066 ml/l", "L: 86.68 %"] placeAnnotations(): Placing annotation 12: Sebastes elongatus Ancillary data = ["Sebastes elongatus", "P: 208.7 db", "T: 9.043 C", "S: 33.96", "O: 2.074 ml/l", "L: 86.6 %"] placeAnnotations(): Placing annotation 14: Stylasterias forreri Ancillary data = ["Stylasterias forreri", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 16: equipment Ancillary data = ["equipment", "P: 210 db", "T: 9.032 C", "S: 33.962", "O: 2.054 ml/l", "L: 86.4 %"] placeAnnotations(): Placing annotation 18: equipment Ancillary data = ["equipment", "P: 209.9 db", "T: 9.03 C", "S: 33.962", "O: 2.052 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 20: equipment Ancillary data = ["equipment", "P: 209.9 db", "T: 9.021 C", "S: 33.966", "O: 2.038 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 22: equipment Ancillary data = ["equipment", "P: 209.3 db", "T: 9.025 C", "S: 33.971", "O: 2.009 ml/l", "L: 86.4 %"] placeAnnotations(): Placing annotation 24: equipment Ancillary data = ["equipment", "P: 209.5 db", "T: 9.028 C", "S: 33.966", "O: 2.025 ml/l", "L: 86.35 %"] placeAnnotations(): Placing annotation 26: equipment Ancillary data = ["equipment", "P: 209.5 db", "T: 8.99 C", "S: 33.976", "O: 1.988 ml/l", "L: 86.22 %"] placeAnnotations(): Placing annotation 28: equipment Ancillary data = ["equipment", "P: 209.3 db", "T: 8.997 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.39 %"] placeAnnotations(): Placing annotation 30: Doryteuthis opalescens Ancillary data = ["Doryteuthis opalescens", "P: 209 db", "T: 9 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.33 %"] placeAnnotations(): Placing annotation 32: ink Ancillary data = ["ink", "P: 203.8 db", "T: 9.046 C", "S: 33.958", "O: 2.072 ml/l", "L: 86.58 %"] placeAnnotations(): Placing annotation 34: Nanomia bijuga Ancillary data = ["Nanomia bijuga", "P: 164.9 db", "T: 9.679 C", "S: 33.761", "O: 2.695 ml/l", "L: 86.03 %"] placeAnnotations(): Placing annotation 36: Doryteuthis opalescens Ancillary data = ["Doryteuthis opalescens", "P: 113.1 db", "T: 10.091 C", "S: 33.624", "O: 3.232 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 38: Mitrocoma cellularia Ancillary data = ["Mitrocoma cellularia", "P: 67.8 db", "T: 11.005 C", "S: 33.465", "O: 3.833 ml/l", "L: 86.37 %"] placeAnnotations(): Placing annotation 40: equipment Ancillary data = ["equipment", "P: 209 db", "T: 9 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.33 %"] placeAnnotations(): Placing annotation 42: equipment Ancillary data = ["equipment", "P: 208.3 db", "T: 9.017 C", "S: 33.968", "O: 2.015 ml/l", "L: 86.45 %"] placeAnnotations(): Placing annotation 44: equipment Ancillary data = ["equipment", "P: 208 db", "T: 9.026 C", "S: 33.965", "O: 2.048 ml/l", "L: 86.54 %"] placeAnnotations(): Placing annotation 46: equipment Ancillary data = ["equipment", "P: 206.8 db", "T: 9.03 C", "S: 33.964", "O: 2.041 ml/l", "L: 86.5 %"] placeAnnotations(): Placing annotation 48: Ancillary data = ["", "P: 206.8 db", "T: 9.03 C", "S: 33.964", "O: 2.041 ml/l", "L: 86.5 %"] inline_name = vnta3816anno02.wrl bin\geopdvc.pl: Calling placeAnnotations with every 1 annotation... placeAnnotations(): Placing annotation 1: sunlit water Ancillary data = ["sunlit water", "P: 208.4 db", "T: 9.034 C", "S: 33.965", "O: 2.066 ml/l", "L: 86.7 %"] placeAnnotations(): Placing annotation 2: Squalus suckleyi Ancillary data = ["Squalus suckleyi", "P: 208.4 db", "T: 9.034 C", "S: 33.965", "O: 2.066 ml/l", "L: 86.7 %"] placeAnnotations(): Placing annotation 3: Florometra serratissima Ancillary data = ["Florometra serratissima", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 4: Parastichopus Ancillary data = ["Parastichopus", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 5: sunlit water Ancillary data = ["sunlit water", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 6: asteroid feeding depression Ancillary data = ["asteroid feeding depression", "P: 208.4 db", "T: 9.034 C", "S: 33.965", "O: 2.066 ml/l", "L: 86.7 %"] placeAnnotations(): Placing annotation 7: Strongylocentrotus fragilis Ancillary data = ["Strongylocentrotus fragilis", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 8: Praya Ancillary data = ["Praya", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 9: Hydrolagus colliei Ancillary data = ["Hydrolagus colliei", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 10: Stylasterias forreri Ancillary data = ["Stylasterias forreri", "P: 207.5 db", "T: 9.036 C", "S: 33.963", "O: 2.066 ml/l", "L: 86.68 %"] placeAnnotations(): Placing annotation 11: Squalus suckleyi Ancillary data = ["Squalus suckleyi", "P: 207.6 db", "T: 9.041 C", "S: 33.961", "O: 2.074 ml/l", "L: 86.69 %"] placeAnnotations(): Placing annotation 12: Sebastes elongatus Ancillary data = ["Sebastes elongatus", "P: 208.7 db", "T: 9.043 C", "S: 33.96", "O: 2.074 ml/l", "L: 86.6 %"] placeAnnotations(): Placing annotation 13: Strongylocentrotus fragilis Ancillary data = ["Strongylocentrotus fragilis", "P: 209.6 db", "T: 9.038 C", "S: 33.962", "O: 2.069 ml/l", "L: 86.57 %"] placeAnnotations(): Placing annotation 14: Stylasterias forreri Ancillary data = ["Stylasterias forreri", "P: 208.7 db", "T: 9.036 C", "S: 33.964", "O: 2.064 ml/l", "L: 86.72 %"] placeAnnotations(): Placing annotation 15: equipment Ancillary data = ["equipment", "P: 210 db", "T: 9.032 C", "S: 33.964", "O: 2.049 ml/l", "L: 86.55 %"] placeAnnotations(): Placing annotation 16: equipment Ancillary data = ["equipment", "P: 210 db", "T: 9.032 C", "S: 33.962", "O: 2.054 ml/l", "L: 86.4 %"] placeAnnotations(): Placing annotation 17: equipment Ancillary data = ["equipment", "P: 210 db", "T: 9.03 C", "S: 33.963", "O: 2.052 ml/l", "L: 86.45 %"] placeAnnotations(): Placing annotation 18: equipment Ancillary data = ["equipment", "P: 209.9 db", "T: 9.03 C", "S: 33.962", "O: 2.052 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 19: equipment Ancillary data = ["equipment", "P: 209.9 db", "T: 9.03 C", "S: 33.962", "O: 2.052 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 20: equipment Ancillary data = ["equipment", "P: 209.9 db", "T: 9.021 C", "S: 33.966", "O: 2.038 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 21: equipment Ancillary data = ["equipment", "P: 209.9 db", "T: 9.011 C", "S: 33.969", "O: 2.026 ml/l", "L: 86.53 %"] placeAnnotations(): Placing annotation 22: equipment Ancillary data = ["equipment", "P: 209.3 db", "T: 9.025 C", "S: 33.971", "O: 2.009 ml/l", "L: 86.4 %"] placeAnnotations(): Placing annotation 23: equipment Ancillary data = ["equipment", "P: 209.5 db", "T: 9.028 C", "S: 33.966", "O: 2.025 ml/l", "L: 86.35 %"] placeAnnotations(): Placing annotation 24: equipment Ancillary data = ["equipment", "P: 209.5 db", "T: 9.028 C", "S: 33.966", "O: 2.025 ml/l", "L: 86.35 %"] placeAnnotations(): Placing annotation 25: equipment Ancillary data = ["equipment", "P: 209.5 db", "T: 9.016 C", "S: 33.969", "O: 2.021 ml/l", "L: 86.27 %"] placeAnnotations(): Placing annotation 26: equipment Ancillary data = ["equipment", "P: 209.5 db", "T: 8.99 C", "S: 33.976", "O: 1.988 ml/l", "L: 86.22 %"] placeAnnotations(): Placing annotation 27: equipment Ancillary data = ["equipment", "P: 209.3 db", "T: 8.997 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.39 %"] placeAnnotations(): Placing annotation 28: equipment Ancillary data = ["equipment", "P: 209.3 db", "T: 8.997 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.39 %"] placeAnnotations(): Placing annotation 29: equipment Ancillary data = ["equipment", "P: 209 db", "T: 9 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.33 %"] placeAnnotations(): Placing annotation 30: Doryteuthis opalescens Ancillary data = ["Doryteuthis opalescens", "P: 209 db", "T: 9 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.33 %"] placeAnnotations(): Placing annotation 31: Doryteuthis opalescens Ancillary data = ["Doryteuthis opalescens", "P: 204.9 db", "T: 9.04 C", "S: 33.96", "O: 2.061 ml/l", "L: 86.57 %"] placeAnnotations(): Placing annotation 32: ink Ancillary data = ["ink", "P: 203.8 db", "T: 9.046 C", "S: 33.958", "O: 2.072 ml/l", "L: 86.58 %"] placeAnnotations(): Placing annotation 33: larvacean house Ancillary data = ["larvacean house", "P: 199.2 db", "T: 9.139 C", "S: 33.924", "O: 2.139 ml/l", "L: 86.34 %"] placeAnnotations(): Placing annotation 34: Nanomia bijuga Ancillary data = ["Nanomia bijuga", "P: 164.9 db", "T: 9.679 C", "S: 33.761", "O: 2.695 ml/l", "L: 86.03 %"] placeAnnotations(): Placing annotation 35: Mitrocoma cellularia Ancillary data = ["Mitrocoma cellularia", "P: 113.1 db", "T: 10.091 C", "S: 33.624", "O: 3.232 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 36: Doryteuthis opalescens Ancillary data = ["DoryteuthisframeGrabs(): Can't get http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/315/accesses.txt at bin\geopdvc.pl line 625 opalescens", "P: 113.1 db", "T: 10.091 C", "S: 33.624", "O: 3.232 ml/l", "L: 86.52 %"] placeAnnotations(): Placing annotation 37: sunlit water Ancillary data = ["sunlit water", "P: 105.9 db", "T: 10.224 C", "S: 33.604", "O: 3.278 ml/l", "L: 86.66 %"] placeAnnotations(): Placing annotation 38: Mitrocoma cellularia Ancillary data = ["Mitrocoma cellularia", "P: 67.8 db", "T: 11.005 C", "S: 33.465", "O: 3.833 ml/l", "L: 86.37 %"] placeAnnotations(): Placing annotation 39: equipment Ancillary data = ["equipment", "P: 40.6 db", "T: 11.611 C", "S: 33.38", "O: 4.213 ml/l", "L: 86.24 %"] placeAnnotations(): Placing annotation 40: equipment Ancillary data = ["equipment", "P: 209 db", "T: 9 C", "S: 33.975", "O: 1.989 ml/l", "L: 86.33 %"] placeAnnotations(): Placing annotation 41: equipment Ancillary data = ["equipment", "P: 208.3 db", "T: 9.017 C", "S: 33.968", "O: 2.015 ml/l", "L: 86.45 %"] placeAnnotations(): Placing annotation 42: equipment Ancillary data = ["equipment", "P: 208.3 db", "T: 9.017 C", "S: 33.968", "O: 2.015 ml/l", "L: 86.45 %"] placeAnnotations(): Placing annotation 43: equipment Ancillary data = ["equipment", "P: 208 db", "T: 9.026 C", "S: 33.965", "O: 2.048 ml/l", "L: 86.54 %"] placeAnnotations(): Placing annotation 44: equipment Ancillary data = ["equipment", "P: 208 db", "T: 9.026 C", "S: 33.965", "O: 2.048 ml/l", "L: 86.54 %"] placeAnnotations(): Placing annotation 45: equipment Ancillary data = ["equipment", "P: 208.1 db", "T: 9.031 C", "S: 33.965", "O: 2.04 ml/l", "L: 86.54 %"] placeAnnotations(): Placing annotation 46: equipment Ancillary data = ["equipment", "P: 206.8 db", "T: 9.03 C", "S: 33.964", "O: 2.041 ml/l", "L: 86.5 %"] placeAnnotations(): Placing annotation 47: equipment Ancillary data = ["equipment", "P: 206.8 db", "T: 9.03 C", "S: 33.964", "O: 2.041 ml/l", "L: 86.5 %"] placeAnnotations(): Placing annotation 48: Ancillary data = ["", "P: 206.8 db", "T: 9.03 C", "S: 33.964", "O: 2.041 ml/l", "L: 86.5 %"] inline_name = vnta3816anno01.wrl frameGrabs(): Getting images from http://search.mbari.org/ARCHIVE/frameGrabs/Ventana/stills/2014/vnta3816... frameGrabs(): matched 00_00_15_26 in