Running .\bin\pdkc.pl at Wed Aug 26 09:35:02 2015 on host ephyra-vm2

Command line:
.\bin\pdkc.pl -rov vnta -dive 1887

.\bin\pdkc.pl: Getting Expedition object for diveno = 1887 and rname = vnta
set_expd(): rov = vnta, diveno = 1887
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 = 1887 AND RovName = 'vnta'

RS->Fields(0)->Value= 2092

RS->Fields(1)->Value= 977249640

RS->Fields(2)->Value= 977275020

RS->Fields(3)->Value= 12/19/2000 6:14:00 PM

RS->Fields(4)->Value= 12/20/2000 1:17:00 AM

set_expd(): $self->{EndDDD} = 355
set_expd(): $self->{StartEsecs} = 977248440
set_expd(): $self->{EndEsecs} = 977276220
set_expd(): $self->{EndDtg} = 12/20/2000 1:17:00 AM
_readLogr(): Reading videologr data from 2000354datavislogr.dat.gz. 
_readLogr(): Expedition start & stop times are 977248440 & 977276220
_readLogr(): Flushing variable names:
_readLogr(): esecs of file line[0] = 977270393, self->{EndEsecs} = 977276220
_readLogr(): Calling _readAnotherLogr() with nextDDD = 355
_readAnotherLogr(): DDD = 355
_readAnotherLogr(): Reading logr data from 2000355datavislogr.dat.gz. 
_readAnotherLogr(): Expedition start & stop times are 977248440 & 977276220
_readAnotherLogr(): esecs of file line[0] = 977276229, self->{EndEsecs} = 977276220
_readLogr(): #LOGHOST_SYSTEM_UTC = 2772
_readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 977248449
_readLogr(): $LOGHOST_SYSTEM_UTC[end] = 977276219
set_expd(): Calling _refineStartAndEndEsecs...
refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 977248449
refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 977276219
refineStartAndEndEsecs(): setting StartEsecs to 977248440
refineStartAndEndEsecs(): setting EndEsecs to 977248890
refineStartAndEndEsecs(): numMinBack = 14.5, numMinForward = 18.15
refineStartAndEndEsecs(): Refined StartEsecs = 977248770, Refined EndEsecs = 977276109 
_readLogr(): Reading videologr data from 2000354datavislogr.dat.gz. 
_readLogr(): Expedition start & stop times are 977248770 & 977276109
_readLogr(): Flushing variable names:
_readLogr(): esecs of file line[0] = 977270393, self->{EndEsecs} = 977276109
_readLogr(): Calling _readAnotherLogr() with nextDDD = 355
_readAnotherLogr(): DDD = 355
_readAnotherLogr(): Reading logr data from 2000355datavislogr.dat.gz. 
_readAnotherLogr(): Expedition start & stop times are 977248770 & 977276109
_readAnotherLogr(): esecs of file line[0] = 977276119, self->{EndEsecs} = 977276109
_readLogr(): #LOGHOST_SYSTEM_UTC = 2728
_readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 977248780
_readLogr(): $LOGHOST_SYSTEM_UTC[end] = 977276109
rovnavCTDO(): calcUTM = 0
rovnavCTDO(): getRaw = 1
rovNav(): 1, getRaw = 1
rovNav(): 2, calcUTM = 0
rovNav(): calcUTM = 0
rovNav(): DDD = 354 (looping to 355) 
Does file exist?: \\atlas\RovNavEdit\2000\vnta\nav2000354vntaedited.txt
   yes.
EXPD.pm: editNav flag = 
rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2000\vnta\nav2000354vnta.txt
esecs, east, north, lat, lon, head, pres
977252285,  564513, 4066801,  36.744753, -122.277350,   5.1,  999.55
977254793,  564501, 4066877,  36.745445, -122.277478, 304.5, 1010.71
rovNav(): 354: 1450  in tList after reading from \\atlas\RovNavEdit\2000\vnta\nav2000354vnta.txt
rovNav(): DDD = 355 (looping to 355) 
rovNav(): \\atlas\RovNavEdit\2000\vnta\nav2000355vnta.txt and \\atlas\RovNavEdit\2000\vnta\nav2000355vntaedited.txt does not exist.  Skipping this file...
1450 in tList
1450 in {self->{rovT}}
1450 in {self->{rovH}}
rovCTDO(): ROV CTDO start & stop times are   977251710 & 977253345
rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.):
...............................................XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX...............................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................XX
rovGDCListRefs(): dMedian = 782.742197312634
rovGDCListRefs(): dStats->sample_range = 1001.93901927609
rovGDCListRefs(): returning (1st elements): 977249541  36.696360 -122.055520  31.6 2.11426079240832
rovNav(): 1, calcUTM = 0
rovNav(): 2, doNotRefineStartEnd = 1
rovNav(): calcUTM = 0
rovNav(): DDD = 354 (looping to 355) 
Does file exist?: \\atlas\RovNavEdit\2000\vnta\nav2000354vntaedited.txt
   yes.
EXPD.pm: editNav flag = 
rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2000\vnta\nav2000354vntaedited.txt
esecs, east, north, lat, lon, head, pres
977252285,       0,       0,  36.744849, -122.277247,   5.1,  999.55
977254793,       0,       0,  36.745202, -122.277668, 304.5, 1010.71
rovNav(): 354: 1450  in tList after reading from \\atlas\RovNavEdit\2000\vnta\nav2000354vntaedited.txt
rovNav(): DDD = 355 (looping to 355) 
rovNav(): \\atlas\RovNavEdit\2000\vnta\nav2000355vnta.txt and \\atlas\RovNavEdit\2000\vnta\nav2000355vntaedited.txt does not exist.  Skipping this file...
1450 in tList
1450 in {self->{rovT}}
1450 in {self->{rovH}}
rovGDCListRefs(): dMedian = 785.194543370552
rovGDCListRefs(): dStats->sample_range = 1001.9389792334
rovGDCListRefs(): returning (1st elements): 977249541  36.744798 -122.277274  31.6 2.11425173660986

.\bin\pdkc.pl: -------------------------------------------------------------------------------

Position subsampling set to 1
reportText = ARRAY(0x25013d4)
reportText = 
Building KML for framegrabs
placeKmlImages(): Looking in \\atlas\framegrabs\Ventana\stills\2000\vnta1887 for .jpgs...
placeKmlImages(): imageFile = 04?12?11?29.jpg
placeKmlImages(): imageFile = 01?05?56?10.jpg
placeKmlImages(): imageFile = 00?59?14?28.jpg
placeKmlImages(): imageFile = 00?58?27?00.jpg
placeKmlImages(): imageFile = 04?16?00?23.jpg
placeKmlImages(): imageFile = 02?27?02?16.jpg
placeKmlImages(): imageFile = 02?32?19?21.jpg
placeKmlImages(): imageFile = 04?11?51?15.jpg
placeKmlImages(): imageFile = 00?44?52?23.jpg
placeKmlImages(): imageFile = 01?13?45?26.jpg
placeKmlImages(): imageFile = 00?25?33?28.jpg
placeKmlImages(): imageFile = 02?14?34?08.jpg
placeKmlImages(): imageFile = 04?15?49?08.jpg
placeKmlImages(): imageFile = 01?12?19?13.jpg
placeKmlImages(): imageFile = 04?37?02?27.jpg
placeKmlImages(): imageFile = 00?00?00?01.jpg
placeKmlImages(): imageFile = 02?05?46?23.jpg
placeKmlImages(): imageFile = 02?30?45?24.jpg
placeKmlImages(): imageFile = 01?13?29?11.jpg
placeKmlImages(): imageFile = 02?21?49?25.jpg
placeKmlImages(): imageFile = 02?23?14?22.jpg
placeKmlImages(): imageFile = 01?13?04?27.jpg
placeKmlImages(): imageFile = 02?24?52?20.jpg
placeKmlImages(): imageFile = 00?34?20?28.jpg
placeKmlImages(): imageFile = 01?04?10?05.jpg
placeKmlImages(): imageFile = 01?06?22?09.jpg
placeKmlImages(): imageFile = 01?20?52?13.jpg
placeKmlImages(): imageFile = 02?06?25?22.jpg
placeKmlImages(): imageFile = 04?15?21?09.jpg
placeKmlImages(): imageFile = 02?27?30?00.jpg
pCannot opendir \\atlas\digitalImages\Ventana\2000\vnta1887: No such file or directory
laceKmlImages(): imageFile = 04?32?38?19.jpg
placeKmlImages(): imageFile = 02?24?23?06.jpg
placeKmlImages(): imageFile = 02?22?34?09.jpg
placeKmlImages(): imageFile = 02?25?32?03.jpg
placeKmlImages(): imageFile = 02?07?58?19.jpg
placeKmlImages(): imageFile = 02?25?14?04.jpg
placeKmlImages(): imageFile = 01?41?42?07.jpg
placeKmlImages(): imageFile = 01?12?43?28.jpg
placeKmlImages(): imageFile = 01?16?38?06.jpg
placeKmlImages(): imageFile = 04?11?31?16.jpg
placeKmlImages(): imageFile = 04?36?44?12.jpg
placeKmlImages(): imageFile = 02?32?14?06.jpg
placeKmlImages(): imageFile = 02?28?40?13.jpg
placeKmlImages(): imageFile = 01?06?37?09.jpg
placeKmlImages(): imageFile = 02?23?33?22.jpg
placeKmlImages(): imageFile = 00?35?37?25.jpg
placeKmlImages(): imageFile = 02?04?58?10.jpg
placeKmlImages(): imageFile = 00?58?46?29.jpg
placeKmlImages(): imageFile = 01?06?08?10.jpg
placeKmlImages(): imageFile = 02?25?53?03.jpg
placeKmlImages(): imageFile = 02?25?42?18.jpg
placeKmlImages(): imageFile = 01?04?31?03.jpg
placeKmlImages(): imageFile = 02?06?15?22.jpg
placeKmlImages(): imageFile = 01?39?49?10.jpg
placeKmlImages(): imageFile = 01?06?15?10.jpg
placeKmlImages(): imageFile = 02?23?45?22.jpg
placeKmlImages(): imageFile = 02?05?26?09.jpg
placeKmlImages(): imageFile = 02?23?40?22.jpg
placeKmlImages(): imageFile = 01?38?35?27.jpg
placeKmlImages(): imageFile = 04?15?34?23.jpg
placeKmlImages(): imageFile = 04?11?41?15.jpg
placeKmlImages(): imageFile = 04?19?22?01.jpg
placeKmlImages(): imageFile = 02?26?26?17.jpg
placeKmlImages(): imageFile = 99?99?99?99-01.jpg
placeKmlImages(): imageFile = 02?24?27?05.jpg
placeKmlImages(): imageFile = 04?16?21?22.jpg
placeKmlImages(): imageFile = 01?12?33?13.jpg
placeKmlImages(): imageFile = 00?27?23?10.jpg
placeKmlImages(): imageFile = 01?40?39?23.jpg
placeKmlImages(): imageFile = 04?15?00?09.jpg
placeKmlImages(): imageFile = 01?39?30?11.jpg
placeKmlImages(): imageFile = 01?04?23?04.jpg
placeKmlImages(): imageFile = 01?06?46?24.jpg
placeKmlImages(): imageFile = 04?32?31?05.jpg
placeKmlImages(): imageFile = 00?54?52?06.jpg
placeKmlImages(): imageFile = 02?21?42?11.jpg
placeKmlImages(): imageFile = 02?24?37?20.jpg
placeKmlImages(): imageFile = 01?53?06?01.jpg
placeKmlImages(): imageFile = 01?40?28?24.jpg
placeKmlImages(): imageFile = 02?28?13?29.jpg
placeKmlImages(): imageFile = 01?47?30?11.jpg
placeKmlImages(): imageFile = 01?39?41?25.jpg
placeKmlImages(): imageFile = 01?05?49?10.jpg
placeKmlImages(): *** No EXIF GPS data found.  Do you need to run dsibydive for this dive? ***
Building KML for digitalImages (Coolpix)
placeKmlImages(): Looking in \\atlas\digitalImages\Ventana\2000\vnta1887 for .jpgs...
placeKmlImages(): *** No EXIF GPS data found.  Do you need to run dsibydive for this dive? ***
Writing file geo2000/vnta/vnta1887.kml...
Writing to file geo2000/vnta/vnta1887_pub.kml...

Adding record to ExpeditionData table...
Executing sql:
exec insertExpeditionData 'GoogleEarth','','',2092,'/3Dreplay/geo2000/vnta/vnta1887.kmz','V1887 Tour','','','',1887