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

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

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

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

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

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

RS->Fields(3)->Value= 5/7/1999 5:16:00 PM

RS->Fields(4)->Value= 5/7/1999 8:19:00 PM

set_expd(): $self->{EndDDD} = 127
set_expd(): $self->{StartEsecs} = 926096160
set_expd(): $self->{EndEsecs} = 926109540
set_expd(): $self->{EndDtg} = 5/7/1999 8:19:00 PM
_readLogr(): Reading videologr data from 1999127videologr.dat.gz. 
_readLogr(): Expedition start & stop times are 926096160 & 926109540
_readLogr(): Flushing variable names:
_readLogr(): esecs of file line[0] = 926109548, self->{EndEsecs} = 926109540
_readLogr(): #LOGHOST_SYSTEM_UTC = 1335
_readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 926096165
_readLogr(): $LOGHOST_SYSTEM_UTC[end] = 926109538
set_expd(): Calling _refineStartAndEndEsecs...
refineStartAndEndEsecs(): LOGHOST_SYSTEM_UTC[0] = 926096165
refineStartAndEndEsecs(): $LOGHOST_SYSTEM_UTC[end] = 926109538
refineStartAndEndEsecs(): setting StartEsecs to 926096160
refineStartAndEndEsecs(): setting EndEsecs to 926097256
refineStartAndEndEsecs(): numMinBack = 3.73333333333333, numMinForward = 21.8
refineStartAndEndEsecs(): Refined StartEsecs = 926097136, Refined EndEsecs = 926109648 
_readLogr(): Reading videologr data from 1999127videologr.dat.gz. 
_readLogr(): Expedition start & stop times are 926097136 & 926109648
_readLogr(): Flushing variable names:
_readLogr(): esecs of file line[0] = 926109658, self->{EndEsecs} = 926109648
_readLogr(): #LOGHOST_SYSTEM_UTC = 1248
_readLogr(): $LOGHOST_SYSTEM_UTC[beg] = 926097146
_readLogr(): $LOGHOST_SYSTEM_UTC[end] = 926109648
rovnavCTDO(): getRaw = 1
rovnavCTDO(): calcUTM = 0
rovNav(): 1, calcUTM = 0
rovNav(): 2, getRaw = 1
rovNav(): calcUTM = 0
rovNav(): DDD = 127 (looping to 127) 
Does file exist?: \\atlas\RovNavEdit\1999\vnta\nav1999127vntaedited.txt
   no.
EXPD.pm: editNav flag = 
rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\1999\vnta\nav1999127vnta.txt
esecs, east, north, lat, lon, head, pres
926102394,  590376, 4070408,  36.775158, -121.987252, 296.9,  187.40
926107403,  590072, 4070592,  36.776843, -121.990632, 252.5,  266.67
rovNav(): 127: 1083  in tList after reading from \\atlas\RovNavEdit\1999\vnta\nav1999127vnta.txt
1083 in tList
1083 in {self->{rovT}}
1083 in {self->{rovH}}
rovCTDO(): ROV CTDO start & stop times are   926098875 & 926100825
rovNavCTDO(): Looking up ROVCTDO data ('.'found, 'X' exceeds max iter.):
...XX......XXXX.......................................................................................................................................X...........................................................X.........................................................................................................XX.....................................X.......................................XX...........................................................................................................................X.........................................................................................................................................................................................................X......................................X.............................................................................................................................................................................................................................................................................................................................
rovGDCListRefs(): dMedian = 188.791000440722
rovGDCListRefs(): dStats->sample_range = 404.737173874697
rovGDCListRefs(): returning (1st elements): 926097329  36.783175 -121.898583 283.5 2.01498474272079
rovNav(): 1, doNotRefineStartEnd = 1
rovNav(): 2, calcUTM = 0
rovNav(): calcUTM = 0
rovNav(): DDD = 127 (looping to 127) 
Does file exist?: \\atlas\RovNavEdit\1999\vnta\nav1999127vntaedited.txt
   no.
EXPD.pm: editNav flag = 
rovNav(): Opening ROV nav data from \\atlas\RovNavEdit\1999\vnta\nav1999127vnta.txt
esecs, east, north, lat, lon, head, pres
926102394,  590376, 4070408,  36.775158, -121.987252, 296.9,  187.40
926107403,  590072, 4070592,  36.776843, -121.990632, 252.5,  266.67
rovNav(): 127: 1083  in tList after reading from \\atlas\RovNavEdit\1999\vnta\nav1999127vnta.txt
1083 in tList
1083 in {self->{rovT}}
1083 in {self->{rovH}}
rovGDCListRefs(): dMedian = 188.791000440722
rovGDCListRefs(): dStats->sample_range = 404.737173874697
rovGDCListRefs(): returning (1st elements): 926097329  36.783175 -121.898583 283.5 2.01498474272079

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

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

Adding record to ExpeditionData table...
Executing sql:
exec insertExpeditionData 'GoogleEarth','','',1797,'/3Dreplay/geo1999/vnta/vnta1603.kmz','V1603 Tour','','','',1603