Hi,

I stumbled upon the following bug in 2.4.{1,2,3} SD. It hangs every day (when
starting a job) and does not recover. This problem is not present in 2.2.8 SD.

Bacula is running on Debian x86 and a 2-drive Dell ML6020 autochanger. 


-- 
Leszek "Tygrys" Urbanski, SCSA, SCNA
 "UN and OAS, they have their place, I guess,
  But first, send the Marines!" -- Tom Lehrer
     http://cygnus.moo.pl/ -- Cygnus High Altitude Balloon
dircmd.c:217-0 <dird: JobId=28939 job=RootFS-MyHost.2008-11-19_07.30.50 
job_name=RootFS-MyHost client_name=MyHost-fd type=66 level=73 
FileSet=MyHostRootFileSet NoAttr=0 SpoolAttr=0 
FileSetMD5=zg+9J/+4Yg+LP1+az01MeB SpoolData=0 WritePartAfterJob=1 
PreferMountedVols=0
dircmd.c:231-0 Do command: JobId=
job.c:92-0 <dird: JobId=28939 job=RootFS-MyHost.2008-11-19_07.30.50 
job_name=RootFS-MyHost client_name=MyHost-fd type=66 level=73 
FileSet=MyHostRootFileSet NoAttr=0 SpoolAttr=0 
FileSetMD5=zg+9J/+4Yg+LP1+az01MeB SpoolData=0 WritePartAfterJob=1 
PreferMountedVols=0
dircmd.c:217-0 <dird: use storage=ML6020 media_type=LTO3 pool_name=DailyPoolA 
pool_type=Backup append=1 copy=0 stripe=0
dircmd.c:231-0 Do command: use storage=
reserve.c:695-0 jid=28939 <dird: use storage=ML6020 media_type=LTO3 
pool_name=DailyPoolA pool_type=Backup append=1 copy=0 stripe=0
reserve.c:724-0 jid=28939 <dird device: use device=Autochanger
reserve.c:741-0 jid=28939 Storage=ML6020 media_type=LTO3 pool=DailyPoolA 
pool_type=Backup append=1
reserve.c:743-0 jid=28939     Device=Autochanger
reserve.c:919-0 jid=28939 PrefMnt=0 exact=0 suitable=0 chgronly=1
reserve.c:1084-0 jid=28939 search res for Autochanger
reserve.c:1087-0 jid=28939 Try match changer res=Autochanger
reserve.c:1098-0 jid=28939 Try changer device Drive-1
reserve.c:1161-0 jid=28939 chk MediaType device=LTO3 request=LTO3
reserve.c:1184-0 try reserve Drive-1
reserve.c:1198-0 jid=28939 have_vol=0 vol=
reserve.c:1381-0 jid=28939 reserve_append device is "Drive-1" (/dev/nst0)
reserve.c:1459-0 jid=28939 PrefMnt=0 exact=0 suitable=1 chgronly=1 any=0
reserve.c:1430-0 MaxJobs=0 Jobs=0 reserves=0 Status= Vol=
reserve.c:1406-0 OK dev: "Drive-1" (/dev/nst0) num_writers=0, reserved, pool
matches
reserve.c:481-0 Inc reserve=0 dev="Drive-1" (/dev/nst0)
reserve.c:1208-0 jid=28939 Reserved=1 dev_name=Autochanger mediatype=LTO3 
pool=DailyPoolA ok=1
askdir.c:259-0 dir_find_next_appendable_volume: reserved=1 Vol=
askdir.c:276-0 >dird CatReq Job=RootFS-MyHost.2008-11-19_07.30.50 FindMedia=1 
pool_name=DailyPoolA media_type=LTO3
askdir.c:182-0 <dird 1000 OK VolName=000054 VolJobs=36 VolFiles=88  
VolBlocks=971514 VolBytes=62674375680 VolMounts=554 VolErrors=0
VolWrites=172489107 MaxVolBytes=0 VolCapacityBytes=0 VolStatus=Append Slot=14 
MaxVolJobs=0 MaxVolFiles=0 InChanger=1 VolReadTime=1673578 
VolWriteTime=64792501130 EndFile=87 EndBlock=2757 VolParts=0 LabelType=0 
MediaId=14
askdir.c:205-0 do_reqest_vol_info return true slot=14 Volume=000054
reserve.c:472-0 jid=28939 find_vol=000054 found=1
reserve.c:189-0 jid=28939 List find_volume: 000044 in_use=0 on device "Drive-1" 
(/dev/nst0)
reserve.c:189-0 jid=28939 List find_volume: 000054 in_use=0 on device "Drive-2" 
(/dev/nst1)
reserve.c:645-0 jid=28939 Vol=000054 on "Drive-2" (/dev/nst1) we have "Drive-1" 
(/dev/nst0)
reserve.c:649-0 jid=28939 Vol=000054 dev="Drive-2" (/dev/nst1) not busy.
askdir.c:285-0 Call reserve_volume. Vol=000054
reserve.c:316-0 jid=28939 enter reserve_volume=000054 drive="Drive-1" 
(/dev/nst0)
reserve.c:189-0 jid=28939 List begin reserve_volume: 000044 in_use=0 on device 
"Drive-1" (/dev/nst0)
reserve.c:189-0 jid=28939 List begin reserve_volume: 000054 in_use=0 on device 
"Drive-2" (/dev/nst1)
reserve.c:331-0 jid=28939 Vol attached=000044, newvol=000054 volinuse=0 on 
"Drive-1" (/dev/nst0)
reserve.c:348-0 jid=28939 reserve_vol free vol=000044 at 8e2ae10
reserve.c:582-0 === clear in_use vol=000044
reserve.c:585-0 jid=28939 === remove volume 000044 dev="Drive-1" (/dev/nst0)
reserve.c:189-0 jid=28939 List free_volume: 000054 in_use=0 on device "Drive-2" 
(/dev/nst1)
reserve.c:189-0 jid=28939 List reserve_vol free: 000054 in_use=0 on device 
"Drive-2" (/dev/nst1)
reserve.c:236-0 jid=28939 new Vol=000054 at 8e2ae10 dev="Drive-1" (/dev/nst0)
reserve.c:363-0 jid=28939 Found vol=000054 dev-same=0
reserve.c:370-0 jid=28939 reserve_vol free-tmp vol=000054 at 8e2b070
reserve.c:388-0 ==== jid=28939 Swap vol=000054 from dev="Drive-2" (/dev/nst1) 
to "Drive-1" (/dev/nst0)
reserve.c:575-0 jid=28939 No vol on dev "Drive-1" (/dev/nst0)
reserve.c:418-0 jid=28939 === set in_use. vol=000054 dev="Drive-1" (/dev/nst0)
reserve.c:189-0 jid=28939 List end new volume: 000054 in_use=1 on device 
"Drive-1" (/dev/nst0)
askdir.c:292-0 dir_find_next_appendable_volume return true. vol=000054
reserve.c:1220-0 jid=28939 looking for Volume=000054
reserve.c:1279-0 jid=28939 >dird changer: 3000 OK use device device=Drive-1
reserve.c:1107-0 jid=28939 Device Drive-1 reserved=1 for append.
reserve.c:1053-0 jid=28939 available device found=Autochanger
reserve.c:1068-0 OK dev found. Vol=000054
dircmd.c:217-0 <dird: run
dircmd.c:231-0 Do command: run
job.c:171-0 Run_cmd: run
jcr.c:603-0 OnEntry JobStatus=C set=F
jcr.c:623-0 OnExit JobStatus=F set=F

dircmd.c:179-0 Got a FD connection at 19-Nov-2008 07:43:18
job.c:237-0 Found Job RootFS-MyHost.2008-11-19_07.30.50
job.c:209-0 Running job RootFS-MyHost.2008-11-19_07.30.50
fd_cmds.c:122-0 Start run Job=RootFS-MyHost.2008-11-19_07.30.50
jcr.c:603-0 OnEntry JobStatus=F set=R
jcr.c:623-0 OnExit JobStatus=R set=R
fd_cmds.c:160-0 <filed: append open session
fd_cmds.c:228-0 Append open session: append open session
fd_cmds.c:238-0 >filed: 3000 OK open ticket = 86
fd_cmds.c:160-0 <filed: append data 86
fd_cmds.c:190-0 Append data: append data 86
fd_cmds.c:192-0 <bfiled: append data 86
append.c:73-0 Start append data. res=1
acquire.c:346-0 acquire_append device is tape
acquire.c:378-0 jid=28939 Do mount_next_write_vol
mount.c:77-0 Enter mount_next_volume(release=0) dev="Drive-1" (/dev/nst0)
mount.c:88-0 mount_next_vol retry=0
mount.c:540-0 Swap unloading slot=14 "Drive-2" (/dev/nst1)
acquire.c:522-0 JobId=28938 broadcast wait_device_release at 19-Nov-2008 
07:43:22

and then it hangs.
-------------------------------------------------------------------------
This SF.Net email is sponsored by the Moblin Your Move Developer's challenge
Build the coolest Linux based applications with Moblin SDK & win great prizes
Grand prize is a trip for two to an Open Source event anywhere in the world
http://moblin-contest.org/redirect.php?banner_id=100&url=/
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

Reply via email to