Bacula-users

[Bacula-users] restore runs infinite (long mail due debug output)

2008-06-30 12:59:16
Subject: [Bacula-users] restore runs infinite (long mail due debug output)
From: Udo Lembke <ulembke AT abc-digital DOT com>
To: bacula-users AT lists.sourceforge DOT net
Date: Mon, 30 Jun 2008 19:02:29 +0200
Hello List,
i use Bacula for a while, but now i have a problem to recover an 
imap-archive from one user (just over 23000 Files, 14GB).
If i start the recover (the backup-job is migrated to tapes) bat show 
the job is running, but nothing happens. After an hour i cancel the job.
Perhaps someone have a hint for me?
I have got the data alredy back with bextract, but it should work with 
bat also, i think.

Best regards

Udo Lembke

Here ist the debug-output from sd (NMD264L2 is the right tape for the job):

admin-sd: dev.c:367-0 Try open "Drive-1" (/dev/nst0) mode=OPEN_READ_ONLY
admin-sd: dev.c:389-0 Rewind after open
admin-sd: bnet.c:667-0 who=client host=172.20.3.21 port=36643
admin-sd: dircmd.c:173-0 Conn: Hello Director admin-dir calling
admin-sd: dircmd.c:188-0 Got a DIR connection at 30-Jun-2008 17:53:26
admin-sd: jcr.c:603-0 OnEntry JobStatus=admin-sd: jcr.c:623-0 OnExit 
JobStatus=C set=C
admin-sd: cram-md5.c:73-0 send: auth cram-md5 <1503317410.1214841206@admin-sd> 
ssl=0
admin-sd: cram-md5.c:133-0 cram-get received: auth cram-md5 
<170137960.1214841206@admin-dir> ssl=0
admin-sd: cram-md5.c:152-0 sending resp to challenge: y3/KG8JNw4+eiAYJXQ8n7A
admin-sd: dircmd.c:210-0 Message channel init completed.
admin-sd: dev.c:2437-0 In set_os_device_parameters
admin-sd: dev.c:2443-0 Set block size to zero
admin-sd: dev.c:2459-0 MTSETDRVBUFFER
admin-sd: dev.c:441-0 open dev: tape 3 opened
admin-sd: dev.c:316-0 preserve=0x0 fd=3
admin-sd: device.c:294-0 open dev "Drive-1" (/dev/nst0) OK
admin-sd: label.c:81-0 Enter read_volume_label res=0 device="Drive-1" 
(/dev/nst0) vol= dev_Vol=*NULL*
admin-sd: label.c:149-0 Big if statement in read_volume_label
admin-sd: label.c:215-0 Call reserve_volume=NMD264L2
admin-sd: label.c:216-0 === dcr->dev=6867d8 dev=6867d8
admin-sd: reserve.c:316-0 jid=0 enter reserve_volume=NMD264L2 drive="Drive-1" 
(/dev/nst0)
admin-sd: reserve.c:236-0 jid=0 new Vol=NMD264L2 at 6918d8 dev="Drive-1" 
(/dev/nst0)
admin-sd: reserve.c:422-0 jid=0 === set in_use. vol=NMD264L2 dev="Drive-1" 
(/dev/nst0)
admin-sd: reserve.c:189-0 jid=0 List end new volume: NMD264L2 in_use=1 on 
device "Drive-1" (/dev/nst0)
admin-sd: label.c:223-0 === dcr->dev=6867d8 dev=6867d8
admin-sd: label.c:226-0 Compare Vol names: VolName=NMD264L2 hdr=NMD264L2
admin-sd: label.c:243-0 Copy vol_name=NMD264L2

Volume Label:
Id                : Bacula 1.0 immortal
VerNo             : 11
VolName           : NMD264L2
PrevVolName       :
VolFile           : 0
LabelType         : VOL_LABEL
LabelSize         : 157
PoolName          : Default
MediaType         : LTO-2
PoolType          : Backup
HostName          : admin
Date label written: 08-Nov-2007 12:56
admin-sd: label.c:248-0 Leave read_volume_label() VOL_OK
admin-sd: reserve.c:568-0 jid=0 === set not reserved vol=NMD264L2 num_writers=0 
dev_reserved=0 dev="Drive-1" (/dev/nst0)
admin-sd: job.c:92-0 <dird: JobId=10065 job=RestoreFiles.2008-06-30_17.53.25 
job_name=RestoreFiles client_name=mailgate-fd type=82 level=70 FileSet=web-srv3 
NoAttr=0 SpoolAttr=0 FileSetMD5=**Dummy** SpoolData=0 WritePartAfterJob=1 
PreferMountedVols=1
admin-sd: job.c:156-0 >dird jid=10065: 3000 OK Job SDid=1 SDtime=1214841147 
Authorization=KDAI-EDJL-FKKD-CEBB-DDJF-ADJE-MNCM-OKBA
admin-sd: pythonlib.c:237-0 No startup module.
admin-sd: reserve.c:708-0 jid=10065 <dird: use storage= media_type=LTO-2 
pool_name=Default pool_type=Backup append=0 copy=0 stripe=0
admin-sd: reserve.c:737-0 jid=10065 <dird device: use device=Drive-1
admin-sd: reserve.c:754-0 jid=10065 Storage= media_type=LTO-2 pool=Default 
pool_type=Backup append=0
admin-sd: reserve.c:756-0 jid=10065     Device=Drive-1
admin-sd: reserve.c:932-0 jid=10065 PrefMnt=1 exact=1 suitable=0 chgronly=0
admin-sd: reserve.c:1097-0 jid=10065 search res for Drive-1
admin-sd: reserve.c:1100-0 jid=10065 Try match changer res=ARCvault
admin-sd: reserve.c:1129-0 jid=10065 Try match res=FileStorage
admin-sd: reserve.c:1129-0 jid=10065 Try match res=Drive-1
admin-sd: reserve.c:1169-0 jid=10065 chk MediaType device=LTO-2 request=LTO-2
admin-sd: reserve.c:1192-0 try reserve Drive-1
admin-sd: reserve.c:485-0 Inc reserve=0 dev="Drive-1" (/dev/nst0)
admin-sd: reserve.c:1274-0 jid=10065 Read reserved=1 dev_name=Drive-1 
mediatype=LTO-2 pool=Default ok=1
admin-sd: reserve.c:1287-0 jid=10065 >dird changer: 3000 OK use device 
device=Drive-1
admin-sd: reserve.c:1144-0 jid=10065 Device Drive-1 reserved=1 for read.
admin-sd: reserve.c:1066-0 jid=10065 available device found=Drive-1
admin-sd: reserve.c:1081-0 OK dev found. Vol=
admin-sd: jcr.c:603-0 OnEntry JobStatus=C set=F
admin-sd: jcr.c:623-0 OnExit JobStatus=F set=F
admin-sd: job.c:190-0 RestoreFiles.2008-06-30_17.53.25 waiting 1800 sec for FD 
to contact SD key=KDAI-EDJL-FKKD-CEBB-DDJF-ADJE-MNCM-OKBA
admin-sd: bnet.c:667-0 who=client host=62.206.40.27 port=36643
admin-sd: dircmd.c:173-0 Conn: Hello Start Job RestoreFiles.2008-06-30_17.53.25
admin-sd: dircmd.c:179-0 Got a FD connection at 30-Jun-2008 17:54:26
admin-sd: job.c:233-0 Found Job RestoreFiles.2008-06-30_17.53.25
admin-sd: cram-md5.c:73-0 send: auth cram-md5 <1326064536.1214841266@admin-sd> 
ssl=0
admin-sd: cram-md5.c:133-0 cram-get received: auth cram-md5 
<864426312.1214841265@mailgate-fd> ssl=0
admin-sd: cram-md5.c:152-0 sending resp to challenge: 7692O0/xJlsUaTQdb5+iwD
admin-sd: job.c:250-0 OK Authentication jid=10065 Job 
RestoreFiles.2008-06-30_17.53.25
admin-sd: job.c:209-0 Running job RestoreFiles.2008-06-30_17.53.25
admin-sd: fd_cmds.c:122-0 Start run Job=RestoreFiles.2008-06-30_17.53.25
admin-sd: jcr.c:603-0 OnEntry JobStatus=F set=R
admin-sd: jcr.c:623-0 OnExit JobStatus=R set=R
admin-sd: fd_cmds.c:160-0 <filed: read open session =  1 1214841147 0 0 0 0
admin-sd: fd_cmds.c:297-0 read open session =  1 1214841147 0 0 0 0

admin-sd: fd_cmds.c:312-0 read_open_session got: JobId=10065 Vol=1 
VolSessId=1214841147 VolSessT=0
admin-sd: fd_cmds.c:315-0   StartF=0 EndF=0 StartB=0 EndB=0
admin-sd: fd_cmds.c:323-0 >filed: 3000 OK open ticket = 1
admin-sd: fd_cmds.c:160-0 <filed: bootstrap
admin-sd: fd_cmds.c:360-0 === Bootstrap file ===
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=0-178
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=12929
admin-sd: fd_cmds.c:362-0 Count=1
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=190
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=63088
admin-sd: fd_cmds.c:362-0 Count=1
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=234
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=189083-190811
admin-sd: fd_cmds.c:362-0 Count=1729
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=235
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=190811-192674
admin-sd: fd_cmds.c:362-0 Count=1864
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=236
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=192674-193684
admin-sd: fd_cmds.c:362-0 Count=1011
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=237
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=193684-194578
admin-sd: fd_cmds.c:362-0 Count=895
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=238
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=194578-195539
admin-sd: fd_cmds.c:362-0 Count=962
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=239
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=195539-197086
admin-sd: fd_cmds.c:362-0 Count=1548
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=240
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=197086-198798
admin-sd: fd_cmds.c:362-0 Count=1713
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=241
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=198798-203243
admin-sd: fd_cmds.c:362-0 Count=4446
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=242
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=203243-207871
admin-sd: fd_cmds.c:362-0 Count=4629
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=243
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=207871-211652
admin-sd: fd_cmds.c:362-0 Count=3782
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=244
admin-sd: fd_cmds.c:362-0 VolBlock=0-15499
admin-sd: fd_cmds.c:362-0 FileIndex=211652-212634
admin-sd: fd_cmds.c:362-0 Count=983
admin-sd: fd_cmds.c:362-0 Volume="NMD264L2"
admin-sd: fd_cmds.c:362-0 MediaType="LTO-2"
admin-sd: fd_cmds.c:362-0 Device="Drive-1"
admin-sd: fd_cmds.c:362-0 Slot=5
admin-sd: fd_cmds.c:362-0 VolSessionId=401
admin-sd: fd_cmds.c:362-0 VolSessionTime=1212480361
admin-sd: fd_cmds.c:362-0 VolFile=259
admin-sd: fd_cmds.c:362-0 VolBlock=0-6159
admin-sd: fd_cmds.c:362-0 FileIndex=271690
admin-sd: fd_cmds.c:362-0 Count=1
admin-sd: fd_cmds.c:366-0 === end bootstrap file ===
Next        : 0x6934d8
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 0-178
VolBlock    : 0-15499
FileIndex   : 12929
count       : 1
found       : 0
done        : no
positioning : 1
fast_reject : 1

Next        : 0x6938f8
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 190-190
VolBlock    : 0-15499
FileIndex   : 63088
count       : 1
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x693d18
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 234-234
VolBlock    : 0-15499
FileIndex   : 189083-190811
count       : 1729
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x694138
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 235-235
VolBlock    : 0-15499
FileIndex   : 190811-192674
count       : 1864
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x694558
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 236-236
VolBlock    : 0-15499
FileIndex   : 192674-193684
count       : 1011
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x694978
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 237-237
VolBlock    : 0-15499
FileIndex   : 193684-194578
count       : 895
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x694d98
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 238-238
VolBlock    : 0-15499
FileIndex   : 194578-195539
count       : 962
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x6951b8
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 239-239
VolBlock    : 0-15499
FileIndex   : 195539-197086
count       : 1548
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x6955d8
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 240-240
VolBlock    : 0-15499
FileIndex   : 197086-198798
count       : 1713
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x6959f8
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 241-241
VolBlock    : 0-15499
FileIndex   : 198798-203243
count       : 4446
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x695e18
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 242-242
VolBlock    : 0-15499
FileIndex   : 203243-207871
count       : 4629
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x696238
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 243-243
VolBlock    : 0-15499
FileIndex   : 207871-211652
count       : 3782
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x696658
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 244-244
VolBlock    : 0-15499
FileIndex   : 211652-212634
count       : 983
found       : 0
done        : no
positioning : 0
fast_reject : 0

Next        : 0x0
Root bsr    : 0x692968
VolumeName  : NMD264L2
  MediaType : LTO-2
  Device    : Drive-1
  Slot      : 5
SessId      : 401
SessTime    : 1212480361
VolFile     : 259-259
VolBlock    : 0-6159
FileIndex   : 271690
count       : 1
found       : 0
done        : no
positioning : 0
fast_reject : 0
admin-sd: fd_cmds.c:160-0 <filed: read data 1
admin-sd: fd_cmds.c:277-0 Read data: read data 1
admin-sd: fd_cmds.c:279-0 <bfiled: read data 1
admin-sd: read.c:59-0 Start read data.
admin-sd: acquire.c:113-0 MediaType dcr=LTO-2 dev=LTO-2
admin-sd: reserve.c:316-0 jid=10065 enter reserve_volume=NMD264L2 
drive="Drive-1" (/dev/nst0)
admin-sd: reserve.c:189-0 jid=10065 List begin reserve_volume: NMD264L2 
in_use=0 on device "Drive-1" (/dev/nst0)
admin-sd: reserve.c:331-0 jid=10065 Vol attached=NMD264L2, newvol=NMD264L2 
volinuse=0 on "Drive-1" (/dev/nst0)
admin-sd: reserve.c:339-0 jid=10065 === set reserved vol=NMD264L2 dev="Drive-1" 
(/dev/nst0)
admin-sd: reserve.c:422-0 jid=10065 === set in_use. vol=NMD264L2 dev="Drive-1" 
(/dev/nst0)
admin-sd: reserve.c:189-0 jid=10065 List end new volume: NMD264L2 in_use=1 on 
device "Drive-1" (/dev/nst0)
admin-sd: askdir.c:230-0 >dird CatReq Job=RestoreFiles.2008-06-30_17.53.25 
GetVolInfo VolName=NMD264L2 write=0
admin-sd: askdir.c:182-0 <dird 1000 OK VolName=NMD264L2 VolJobs=91 VolFiles=311 
VolBlocks=3897685 VolBytes=251447519232 VolMounts=5 VolErrors=0 
VolWrites=20789539 MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Full Slot=5 
MaxVolJobs=0 MaxVolFiles=0 InChanger=1 VolReadTime=2749507104 
VolWriteTime=19208922860 EndFile=310 EndBlock=0 VolParts=0 LabelType=0 
MediaId=17
admin-sd: askdir.c:205-0 do_reqest_vol_info return true slot=5 Volume=NMD264L2
admin-sd: mount.c:502-0 swapping: must load "Drive-1" (/dev/nst0)
admin-sd: autochanger.c:132-0 autoload: slot=5 InChgr=1 Vol=NMD264L2
admin-sd: autochanger.c:220-0 After changer, status=0
admin-sd: acquire.c:223-0 bstored: open vol=NMD264L2
admin-sd: acquire.c:231-0 opened dev "Drive-1" (/dev/nst0) OK
admin-sd: acquire.c:234-0 calling read-vol-label
admin-sd: label.c:81-0 Enter read_volume_label res=1 device="Drive-1" 
(/dev/nst0) vol=NMD264L2 dev_Vol=NMD264L2
admin-sd: label.c:149-0 Big if statement in read_volume_label
admin-sd: label.c:215-0 Call reserve_volume=NMD264L2
admin-sd: label.c:216-0 === dcr->dev=6867d8 dev=6867d8
admin-sd: reserve.c:316-0 jid=10065 enter reserve_volume=NMD264L2 
drive="Drive-1" (/dev/nst0)
admin-sd: reserve.c:189-0 jid=10065 List begin reserve_volume: NMD264L2 
in_use=1 on device "Drive-1" (/dev/nst0)
admin-sd: reserve.c:331-0 jid=10065 Vol attached=NMD264L2, newvol=NMD264L2 
volinuse=1 on "Drive-1" (/dev/nst0)
admin-sd: reserve.c:339-0 jid=10065 === set reserved vol=NMD264L2 dev="Drive-1" 
(/dev/nst0)
admin-sd: reserve.c:422-0 jid=10065 === set in_use. vol=NMD264L2 dev="Drive-1" 
(/dev/nst0)
admin-sd: reserve.c:189-0 jid=10065 List end new volume: NMD264L2 in_use=1 on 
device "Drive-1" (/dev/nst0)
admin-sd: label.c:223-0 === dcr->dev=6867d8 dev=6867d8
admin-sd: label.c:226-0 Compare Vol names: VolName=NMD264L2 hdr=NMD264L2
admin-sd: label.c:243-0 Copy vol_name=NMD264L2

Volume Label:
Id                : Bacula 1.0 immortal
VerNo             : 11
VolName           : NMD264L2
PrevVolName       :
VolFile           : 0
LabelType         : VOL_LABEL
LabelSize         : 157
PoolName          : Default
MediaType         : LTO-2
PoolType          : Backup
HostName          : admin
Date label written: 08-Nov-2007 12:56
admin-sd: label.c:248-0 Leave read_volume_label() VOL_OK
admin-sd: jcr.c:603-0 OnEntry JobStatus=R set=R
admin-sd: jcr.c:623-0 OnExit JobStatus=R set=R
admin-sd: reserve.c:494-0 Dec reserve=0 dev="Drive-1" (/dev/nst0)

###### after this point nothing happens....


-- 
Udo Lembke
abc digital | IT-Support
____________________________________________

Albert Bauer KG

Conventstr. 1 - 3
22089 Hamburg | Germany

Fon: +49 40 25109-139
Fax: +49 40 25109-121
mailto:ulembke AT abc-digital DOT com

http://www.abc-digital.com
http://www.prevaco.com
____________________________________________

Albert Bauer KG (GmbH & Co.)
P.H.G. Reproduktionsgesellschaft Conventhaus mbH
Sitz der Gesellschaft: Hamburg
Handelsregister: Amtsgericht Hamburg HRB 11120
Geschäftsführer: Harald Dau, Carsten Dau, Rolf Gehrke, Marcus Müller


-------------------------------------------------------------------------
Check out the new SourceForge.net Marketplace.
It's the best place to buy or sell services for
just about anything Open Source.
http://sourceforge.net/services/buy/index.php
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users

<Prev in Thread] Current Thread [Next in Thread>