On Wed, 2007-05-23 at 15:11 +0200, Lucio wrote:
> Arno Lehmann wrote:
> > > Running Jobs:
> > >  JobId Level   Name                       Status
> > > ======================================================================
> > >     18 Increme  Client1.2007-05-21_12.21.30 is waiting for a mount
> > > request
> > >
> > > (still waiting about 20 minutes after run), and:
> >
> > Ok.
> >
> > Have you tried issuing a mount at this time?
> Now I have. If the media is blank the mount obviously fails and nothing 
> happens. 
> If the media already has at least one session and its appendable the mount 
> succeeds but in bacula still nothing happens.
> 
> > Also, use trace=1, so you have a bconsle command of 'setdebug level=200
> > trace=1 sd=server-Emmeti-sd'
> >
> > Then, look at the trace file in the working directory of the SD... IIRC,
> > it would be called server-Emmeti-sd.trace.
> 
> I post here the parts that I believe can be useful to find the problem 
> (blank DVD media in this case):
> 
> server-Emmeti-sd: askdir.c:204 do_reqest_vol_info return true slot=0 
> Volume=Backup-0003
> server-Emmeti-sd: reserve.c:159 New Vol=Backup-0003 dev="DVD-Writer" 
> (/dev/hdb)
> server-Emmeti-sd: reserve.c:735 JobId=27 looking for Volume=Backup-0003
> server-Emmeti-sd: reserve.c:862 reserve_append device is disk
> server-Emmeti-sd: reserve.c:893 PrefMnt=1 exact=1 suitable=1 chgronly=0 any=0
> server-Emmeti-sd: reserve.c:944 failed: Not exact match have= want=Backup-0003
> server-Emmeti-sd: reserve.c:866 can_reserve_drive!=1
> server-Emmeti-sd: reserve.c:258 free_unused_volume Backup-0003
> server-Emmeti-sd: reserve.c:760 Not OK.
> server-Emmeti-sd: reserve.c:597 Suitable device found=DVD-Writer, not used: 
> busy
> 
The last line does not look good. It says "not used: busy". Are you sure
that you do not have any automount or other automatic mounter running.


> [...]
> 
> server-Emmeti-sd: dircmd.c:206 <dird: run
> server-Emmeti-sd: dircmd.c:220 Do command: run
> server-Emmeti-sd: job.c:153 Run_cmd: run
> server-Emmeti-sd: job.c:172 Client1.2007-05-23_14.01.20 waiting 1800 sec for 
> FD to contact SD
> server-Emmeti-sd: bnet.c:1154 who=client host=127.0.0.1 port=36643
> server-Emmeti-sd: dircmd.c:169 Conn: Hello Start Job 
> Client1.2007-05-23_14.01.20
> server-Emmeti-sd: job.c:214 Found Job Client1.2007-05-23_14.01.20
> 
> [...]
> 
> server-Emmeti-sd: job.c:190 Running job Client1.2007-05-23_14.01.20
> server-Emmeti-sd: fd_cmds.c:122 Start run Job=Client1.2007-05-23_14.01.20
> server-Emmeti-sd: fd_cmds.c:160 <filed: append open session
> server-Emmeti-sd: fd_cmds.c:228 Append open session: append open session
> server-Emmeti-sd: fd_cmds.c:238 >filed: 3000 OK open ticket = 1
> server-Emmeti-sd: fd_cmds.c:160 <filed: append data 1
> server-Emmeti-sd: fd_cmds.c:190 Append data: append data 1
> server-Emmeti-sd: fd_cmds.c:192 <bfiled: append data 1
> server-Emmeti-sd: append.c:73 Start append data. res=1
> server-Emmeti-sd: acquire.c:318 acquire_append device is DVD
> server-Emmeti-sd: acquire.c:384 Not in append mode, try mount.
> server-Emmeti-sd: acquire.c:390 Do mount_next_write_vol
> server-Emmeti-sd: mount.c:74 Enter mount_next_volume(release=0) 
> dev="DVD-Writer" (/dev/hdb)
> server-Emmeti-sd: mount.c:84 mount_next_vol retry=0
> server-Emmeti-sd: mount.c:110 Before dir_find_next_appendable_volume.
> server-Emmeti-sd: askdir.c:252 dir_find_next_appendable_volume
> server-Emmeti-sd: askdir.c:266 >dird: CatReq Job=Client1.2007-05-23_14.01.20 
> FindMedia=1 pool_name=Default media_type=DVD
> server-Emmeti-sd: askdir.c:182 <dird 1000 OK VolName=Backup-0003 VolJobs=0 
> VolFiles=0 VolBlocks=0 VolBytes=0 VolMounts=0 VolErrors=0 VolWrites=0 
> MaxVolBytes=4608000000 VolCapacityBytes=0 VolStatus=Append Slot=0 
> MaxVolJobs=0 MaxVolFiles=0 InChanger=0 VolReadTime=0 VolWriteTime=0 EndFile=0 
> EndBlock=0 VolParts=0 LabelType=0 MediaId=3
> server-Emmeti-sd: askdir.c:204 do_reqest_vol_info return true slot=0 
> Volume=Backup-0003
> server-Emmeti-sd: reserve.c:323 Vol=Backup-0003 not in use.
> server-Emmeti-sd: reserve.c:159 New Vol=Backup-0003 dev="DVD-Writer" 
> (/dev/hdb)
> server-Emmeti-sd: mount.c:122 After find_next_append. Vol=Backup-0003 Slot=0 
> Parts=0
> server-Emmeti-sd: autochanger.c:121 Device "DVD-Writer" (/dev/hdb) is not an 
> autochanger
> server-Emmeti-sd: mount.c:142 autoload_dev returns 0
> server-Emmeti-sd: mount.c:158 Ask=0 autochanger=0
> server-Emmeti-sd: mount.c:168 want vol=Backup-0003
> server-Emmeti-sd: dev.c:295 open dev: type=3 dev_name="DVD-Writer" (/dev/hdb) 
> vol=Backup-0003 mode=OPEN_READ_WRITE
> server-Emmeti-sd: dev.c:302 call open_dvd_device mode=OPEN_READ_WRITE
> server-Emmeti-sd: dev.c:510 Enter: open_dvd_dev: DVD vol= mode=OPEN_READ_WRITE
> server-Emmeti-sd: dev.c:521 Volume=Backup-0003
> server-Emmeti-sd: dev.c:533 Set part=1
> server-Emmeti-sd: dev.c:546 open DVD part=1 num_dvd_parts=0
> server-Emmeti-sd: dev.c:563 open_dvd_device: part=1 num_dvd_parts=0, 
> VolCatInfo.VolCatParts=0
> server-Emmeti-sd: dev.c:1957 Enter mount
> server-Emmeti-sd: dev.c:2005 do_mount: cmd=/bin/mount /dev/hdb mounted=0
> server-Emmeti-sd: dev.c:2017 do_mount run_prog=/bin/mount /dev/hdb
> server-Emmeti-sd: dev.c:1996 ======= mount=0
> server-Emmeti-sd: dev.c:2040 Device "DVD-Writer" (/dev/hdb) cannot be 
> mounted. stat=268435488 result=mount: wrong fs type, bad option, bad 
> superblock on /dev/hdb,
>        missing codepage or other error
>        In some cases useful info is found in syslog - try
>        dmesg | tail  or so
> 
>  ERR=Child exited with code 32
> server-Emmeti-sd: dev.c:2084 do_mount: ignoring . in /media/cdrom0
> server-Emmeti-sd: dev.c:2084 do_mount: ignoring .. in /media/cdrom0
> server-Emmeti-sd: dev.c:2077 do_mount: failed to find suitable file in dir 
> /media/cdrom0 (dev="DVD-Writer" (/dev/hdb))
> server-Emmeti-sd: dev.c:2090 do_mount: got 0 files in the mount point (not 
> counting ., .. and .keep)
> server-Emmeti-sd: dev.c:2110 ============ mount=0
> server-Emmeti-sd: dev.c:612 DVD device mount failed.
> [...]
> 
> Then it retries mounting a few times and finally: 
> 
> server-Emmeti-sd: mount.c:158 Ask=1 autochanger=0
> server-Emmeti-sd: dev.c:1972 Enter unmount
> server-Emmeti-sd: wait.c:65 Enter blocked=BST_DOING_ACQUIRE
> 
> But... er... I find it's quite obvious that mount fails... it's a blank media 
> after all! Shouldn't SD 
> "format" (label) the media before trying to mount it?
> 
Only if you have set automatic label up. From memory your -sd Device
config needs "LabelMedia = Yes" I do not remember if you need to set
anything in the -dir.conf. At a minimum you probably need a
LabelFormat=xxx in the Pool definition

Does the label command work against blank media?

Richard

-- 
Richard Mortimer <[EMAIL PROTECTED]>


-------------------------------------------------------------------------
This SF.net email is sponsored by DB2 Express
Download DB2 Express C - the FREE version of DB2 express and take
control of your XML. No limits. Just data. Click to get it now.
http://sourceforge.net/powerbar/db2/
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

Reply via email to