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

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

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

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

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

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

RS->Fields(3)->Value= 9/19/2000 4:21:45 PM

RS->Fields(4)->Value= 9/19/2000 5:54:15 PM

set_expd(): $self->{EndDDD} = 263
set_expd(): $self->{StartEsecs} = 969379305
set_expd(): $self->{EndEsecs} = 969387255
set_expd(): $self->{EndDtg} = 9/19/2000 5:54:15 PM
_readLogr(): Reading videologr data from 2000263datavislogr.dat.gz. 
_readLogr(): Expedition start & stop times are 969379305 & 969387255
_readLogr(): Flushing variable names:
_readLogr(): esecs of file line[0] = 969387258, self->{EndEsecs} = 969387255
_readLogr(): #LOGHOST_SYSTEM_UTC = 793
_readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 969379308
_readLogr(): $LOGHOST_SYSTEM_UTC[end] = 969387248
set_expd(): Calling _refineStartAndEndEsecs...
refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 969379308
refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 969387248
refineStartAndEndEsecs(): setting StartEsecs to 969379305
refineStartAndEndEsecs(): setting EndEsecs to 969379368
refineStartAndEndEsecs(): numMinBack = 20.95, numMinForward = 21.3833333333333
refineStartAndEndEsecs(): Refined StartEsecs = 969379248, Refined EndEsecs = 969387338 
_readLogr(): Reading videologr data from 2000263datavislogr.dat.gz. 
_readLogr(): Expedition start & stop times are 969379248 & 969387338
_readLogr(): Flushing variable names:
_readLogr(): esecs of file line[0] = 969387339, self->{EndEsecs} = 969387338
_readLogr(): #LOGHOST_SYSTEM_UTC = 806
_readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 969379258
_readLogr(): $LOGHOST_SYSTEM_UTC[end] = 969387329
rovnavCTDO(): getRaw = 1
rovnavCTDO(): calcUTM = 0
rovNav(): 1, calcUTM = 0
rovNav(): 2, getRaw = 1
rovNav(): calcUTM = 0
rovNav(): DDD = 263 (looping to 263) 
Does file exist?: \\atlas\RovNavEdit\2000\vnta\nav2000263vntaedited.txt
   yes.
EXPD.pm: editNav flag = 
rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2000\vnta\nav2000263vnta.txt
esecs, east, north, lat, lon, head, pres
969385514,  576618, 4086517,  36.921570, -122.139778, 135.8,   68.59
rovNav(): 263: 630  in tList after reading from \\atlas\RovNavEdit\2000\vnta\nav2000263vnta.txt
630 in tList
630 in {self->{rovT}}
630 in {self->{rovH}}
rovCTDO(): ROV CTDO start & stop times are   969385320 & 969384660
rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.):
.........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................X
rovGDCListRefs(): dMedian = 67.9715439837249
rovGDCListRefs(): dStats->sample_range = 66.740085007808
rovGDCListRefs(): returning (1st elements): 969380506  36.920612 -122.142193 124.2 4.92321733460275
rovNav(): 1, calcUTM = 0
rovNav(): 2, doNotRefineStartEnd = 1
rovNav(): calcUTM = 0
rovNav(): DDD = 263 (looping to 263) 
Does file exist?: \\atlas\RovNavEdit\2000\vnta\nav2000263vntaedited.txt
   yes.
EXPD.pm: editNav flag = 
rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\2000\vnta\nav2000263vntaedited.txt
esecs, east, north, lat, lon, head, pres
969385514,       0,       0,  36.921563, -122.139768, 135.8,   68.59
rovNav(): 263: 630  in tList after reading from \\atlas\RovNavEdit\2000\vnta\nav2000263vntaedited.txt
630 in tList
630 in {self->{rovT}}
630 in {self->{rovH}}
rovGDCListRefs(): dMedian = 67.9814651879635
rovGDCListRefs(): dStats->sample_range = 66.7400849018769
rovGDCListRefs(): returning (1st elements): 969380506  36.920519 -122.142124 124.2 4.92321737517322

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

Position subsampling set to 1
reportText = ARRAY(0x24a13d4)
reportText = 
Building KML for framegrabs
placeKmlImages(): Looking in \\atlas\framegrabs\Ventana\stills\2000\vnta1827 for .jpgs...
placeKmlImages(): imageFile = 20?34?03.jpg
placeKmlImages(): imageFile = 00?40?21?18.jpg
placeKmlImages(): imageFile = 00?11?46?13.jpg
placeKmlImages(): imageFile = 20?09?18.jpg
placeKmlImages(): imageFile = 00?20?12?19.jpg
placeKmlImages(): imageFile = 00?17?14?02.jpg
placeKmlImages(): imageFile = 00?17?34?02.jpg
placeKmlImages(): imageFile = 14?31?14.jpg
placeKmlImages(): imageFile = 14?42?29.jpg
placeKmlImages(): imageFile = 17?34?02.jpg
placeKmlImages(): imageFile = 24?21?10.jpg
placeKmlImages(): imageFile = 20?12?19.jpg
placeKmlImages(): imageFile = 00?14?40?00.jpg
placeKmlImages(): imageFile = 00?14?48?14.jpg
placeKmlImages(): imageFile = 11?46?13.jpg
placeKmlImages(): imageFile = 14?35?00.jpg
placeKmlImages(): imageFile = 00?15?11?21.jpg
placeKmlImages(): imageFile = 20?28?03.jpg
placeKmlImages(): imageFile = 43?47?18.jpg
placeKmlImages(): imageFile = 00?20?42?17.jpg
placeKmlImages(): imageFile = 00?20?31?02.jpg
placeKmlImages(): imageFile = 00?17?11?02.jpg
placeKmlImages(): imageFile = 17?37?01.jpg
placeKmlImages(): imageFile = 20?42?17.jpg
placeKmlImages(): imageFile = 00?14?35?00.jpg
placeKmlImages(): imageFile = 01?46?18?25.jpg
placeKmlImages(): imageFile = 14?45?14.jpg
placeKmlImages(): imageFile = 00?20?15?04.jpg
placeKmlImages(): imageFile = 00?24?10?11.jpg
placeKmlImages(): imageFile = 00?16?20?04.jpg
placeKmlImages(): imageFile = 17?22?17.jpg
placeKmlImages(): imageFile = 00?17?05?17.jpg
placeKmlImages(): imageFile = 40?24?03.jpg
placeKmlImages(): imageFile = 29?18?01.jpg
placeKmlImages(): imageFile = 00?44?19?19.jpg
placeKmlImages(): imageFile = 17?25?02.jpg
placeKmlImages(): imageFile = 00?16?07?04.jpg
placeKmlImages(): imageFile = 17?17?02.jpg
placeKmlImages(): imageFile = 17?31?17.jpg
placeKmlImages(): imageFile = 00?17?17?02.jpg
placeKmlImages(): imageFile = 17?05?17.jpg
placeKmlImages(): imageFile = 16?07?04.jpg
placeKmlImages(): imageFile = 14?48?14.jpg
placeKmlImages(): imageFile = 20?15?04.jpg
placeKmlImages(): imageFile = 00?24?21?10.jpg
placeKmlImages(): imageFile = 00?14?50?29.jpg
placeKmlImages(): imageFile = 17?14?02.jpg
placeKmlImages(): imageFile = 14?54?14.jpg
placeKmlImages(): imageFile = 00?17?25?02.jpg
placeKmlImages(): imageFile = 00?16?43?18.jpg
placeKmlImages(): imageFile = 00?17?19?17.jpg
placeKmlImages(): imageFile = 00?17?08?17.jpg
placeKmlImages(): imageFile = 00?20?21?18.jpg
placeKmlImages(): imageFile = 00?43?56?25.jpg
placeKmlImages(): imageFile = 00?15?00?28.jpg
placeKmlImages(): imageFile = 00?20?34?03.jpg
placeKmlImages(): imageFile = 00?20?09?18.jpg
placeKmlImages(): imageFile = 20?39?18.jpg
placeKmlImages(): imageFile = 43?56?25.jpg
placeKmlImages(): imageFile = 20?06?12.jpg
placeKmlImages(): imageFile = 14?40?00.jpg
placeKmlImages(): imageFile = 00?14?45?14.jpg
placeKmlImages(): imageFile = 00?43?47?18.jpg
placeKmlImages(): imageFile = 00?17?28?16.jpg
placeKmlImages(): imageFile = 17?28?16.jpg
placeKmlImages(): imageFile = 14?50?29.jpg
placeKmlImages(): imageFile = 16?20?04.jpg
placeKmlImages(): imageFile = 11?36?14.jpg
placeKmlImages(): imageFile = 00?17?03?03.jpg
placeKmlImages(): imageFile = 00?14?37?15.jpg
placeKmlImages(): imageFile = 17?11?02.jpg
placeKmlImages(): imageFile = 24?10?11.jpg
placeKmlImages(): imageFile = 00?17?22?17.jpg
placeKmlImages(): imageFile = 00?14?54?14.jpg
placeKmlImages(): imageFile = 00?14?31?14.jpg
placeKmlImages(): imageFile = 17?03?03.jpg
placeKmlImages(): Cannot opendir \\atlas\digitalImages\Ventana\2000\vnta1827: No such file or directory
imageFile = 00?17?31?17.jpg
placeKmlImages(): imageFile = 00?20?06?12.jpg
placeKmlImages(): imageFile = 20?31?02.jpg
placeKmlImages(): imageFile = 00?15?15?05.jpg
placeKmlImages(): imageFile = 00?17?00?03.jpg
placeKmlImages(): imageFile = 20?24?18.jpg
placeKmlImages(): imageFile = 16?43?18.jpg
placeKmlImages(): imageFile = 00?29?18?01.jpg
placeKmlImages(): imageFile = 20?21?18.jpg
placeKmlImages(): imageFile = 15?00?28.jpg
placeKmlImages(): imageFile = 17?00?03.jpg
placeKmlImages(): imageFile = 00?16?52?02.jpg
placeKmlImages(): imageFile = 00?20?39?18.jpg
placeKmlImages(): imageFile = 15?15?05.jpg
placeKmlImages(): imageFile = 17?19?17.jpg
placeKmlImages(): imageFile = 15?11?21.jpg
placeKmlImages(): imageFile = 00?20?24?18.jpg
placeKmlImages(): imageFile = 00?20?28?03.jpg
placeKmlImages(): imageFile = 00?40?24?03.jpg
placeKmlImages(): imageFile = 00?11?36?14.jpg
placeKmlImages(): imageFile = 00?17?37?01.jpg
placeKmlImages(): imageFile = 00?14?42?29.jpg
placeKmlImages(): imageFile = 17?08?17.jpg
placeKmlImages(): imageFile = 44?19?19.jpg
placeKmlImages(): imageFile = 14?37?15.jpg
placeKmlImages(): imageFile = 40?21?18.jpg
placeKmlImages(): imageFile = 46?18?25.jpg
placeKmlImages(): imageFile = 16?52?02.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\vnta1827 for .jpgs...
placeKmlImages(): *** No EXIF GPS data found.  Do you need to run dsibydive for this dive? ***
Writing file geo2000/vnta/vnta1827.kml...
Writing to file geo2000/vnta/vnta1827_pub.kml...

Adding record to ExpeditionData table...
Executing sql:
exec insertExpeditionData 'GoogleEarth','','',2034,'/3Dreplay/geo2000/vnta/vnta1827.kmz','V1827 Tour','','','',1827