Backup not executing

[Titann]

Hi All,

Version. 7.1.3 server w2k3

I have a problem with one of my backups. It starts at 22:10 in the evening and this morning when I came in I saw it was still running but nothing was backed up.

I then checked the daemon log on the backup server and found this:

08/08/07 22:10:01 nsrd: savegroup info: starting MSSQL2 (with 1 client(s))
08/08/07 22:10:10 nsrd: media info: suggest relabeling MSSQLOnline.404 (000027) on ysapprdvdb.ijnet.co.za for writing to pool 'MSSQL'
08/08/07 22:10:10 nsrd: media waiting event: Waiting for 1 writable volumes to backup pool 'MSSQL' tape(s) or disk(s) on ysapprdvdb.ijnet.co.za
08/08/07 22:10:11 nsrd: nsrjb notice: nsrjb -j R2D2 -O380 -l -R -M -J ysapprdvdb.ijnet.co.za MSSQLOnline.404
08/08/07 22:10:12 nsrd: Jukebox 'R2D2' failed: All of the devices are in use by nsrmmd
08/08/07 22:10:21 nsrd: nsrjb notice: nsrjb -j R2D2 -O381 -l -R -M -J ysapprdvdb.ijnet.co.za MSSQLOnline.404
08/08/07 22:10:22 nsrd: Jukebox 'R2D2' failed: All of the devices are in use by nsrmmd
08/08/07 22:10:34 nsrd: nsrjb notice: nsrjb -j R2D2 -O382 -l -R -M -J ysapprdvdb.ijnet.co.za MSSQLOnline.404
08/08/07 22:10:35 nsrd: Jukebox 'R2D2' failed: All of the devices are in use by nsrmmd
08/08/07 22:10:47 nsrd: nsrjb notice: nsrjb -j R2D2 -O383 -l -R -M -J ysapprdvdb.ijnet.co.za MSSQLOnline.404
08/08/07 22:10:48 nsrd: Jukebox 'R2D2' failed: All of the devices are in use by nsrmmd
08/08/07 22:11:04 nsrd: nsrjb notice: nsrjb -j R2D2 -O385 -l -R -M -J ysapprdvdb.ijnet.co.za MSSQLOnline.404
08/08/07 22:11:06 nsrd: Jukebox 'R2D2' failed: All of the devices are in use by nsrmmd
08/08/07 22:11:06 nsrd: rd=sapqasvdb.ijnet.co.za:\\.\Tape1 2:Eject operation in progress
08/08/07 22:11:24 nsrd: nsrjb notice: nsrjb -j R2D2 -O386 -l -R -M -J ysapprdvdb.ijnet.co.za MSSQLOnline.404
08/08/07 22:11:25 nsrd: Jukebox 'R2D2' failed: All of the devices are in use by nsrmmd
08/08/07 22:11:48 nsrd: nsrjb notice: nsrjb -j R2D2 -O387 -l -R -M -J ysapprdvdb.ijnet.co.za MSSQLOnline.404
08/08/07 22:11:51 nsrd: media info: loading volume MSSQLOnline.404 into rd=ysapprdvdb.ijnet.co.za:\\.\Tape1
08/08/07 22:12:04 nsrd: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 2:Verify label operation in progress
08/08/07 22:12:17 nsrd: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 2:Label without mount operation in progress
08/08/07 22:12:18 nsrd: media info: LTO Ultrium-2 tape MSSQLOnline.404 will be over-written
08/08/07 22:12:18 nsrd: deleted media notice: Deleted volume: volid=3952557881, volname=MSSQLOnline.404, location=R2D2
08/08/07 22:12:24 nsrd: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 is now enabled read/write
08/08/07 22:12:24 nsrd: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 2:Mount operation in progress
08/08/07 22:12:42 nsrd: media event cleared: Waiting for 1 writable volumes to backup pool 'MSSQL' tape(s) or disk(s) on ysapprdvdb.ijnet.co.za
08/08/07 22:12:42 nsrd: ysapprdvdb.ijnet.co.za:MSSQL: saving to pool 'MSSQL' (MSSQLOnline.404)
08/08/07 22:12:43 nsrd: ysapprdvdb.ijnet.co.za:MSSQL: done saving to pool 'MSSQL' (MSSQLOnline.404) 3154 KB
08/08/07 22:12:44 nsrd: ysapprdvdb.ijnet.co.za:MSSQL: saving to pool 'MSSQL' (MSSQLOnline.404)
08/08/07 22:16:05 nsrd: rd=ysapqasvdb.ijnet.co.za:\\.\Tape2 4:Eject operation in progress
08/08/07 22:39:30 nsrd: media critical: TapeAlert flag "Media" has been posted for \\.\Tape1
08/08/07 22:39:30 nsrd: media critical: TapeAlert flag "Clean now" has been posted for \\.\Tape1
08/08/07 22:39:30 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 writing: Invalid argument, at file 26 record 867
08/08/07 22:39:30 nsrd: media notice: LTO Ultrium-2 tape MSSQLOnline.404 on rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 is full
08/08/07 22:39:30 nsrd: media notice: LTO Ultrium-2 tape MSSQLOnline.404 used 48 GB of 95 GB capacity
08/08/07 22:39:30 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 moving: tape_bsf bsf failed: drive status is WRITE ERROR
08/08/07 22:39:30 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 moving: tape_bsf bsf failed: drive status is WRITE ERROR
08/08/07 22:46:54 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 moving: fsf 26: drive status is Media Error, Recorded Entity Not Found
08/08/07 22:46:54 nsrd: media critical: TapeAlert flag "Media" has been cleared for \\.\Tape1
08/08/07 22:51:18 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 moving: fsf 26: drive status is Media Error, Recorded Entity Not Found
08/08/07 22:51:18 nsrd: media critical: TapeAlert flag "Media" has been posted for \\.\Tape1
08/08/07 22:51:18 nsrd: media critical: TapeAlert flag "Media" has been cleared for \\.\Tape1
08/08/07 22:55:43 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 moving: fsf 26: drive status is Media Error, Recorded Entity Not Found
08/08/07 22:55:43 nsrd: media critical: TapeAlert flag "Media" has been posted for \\.\Tape1
08/08/07 22:55:43 nsrd: media critical: TapeAlert flag "Media" has been cleared for \\.\Tape1
08/08/07 22:55:43 nsrd: media emergency: could not position MSSQLOnline.404 to file 26, record 863
08/08/07 22:55:43 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 reading: unknown error 23 (0x17)
08/08/07 22:55:43 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 reading: unknown error 23 (0x17)
08/08/07 22:55:43 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 reading: unknown error 23 (0x17)
08/08/07 22:55:43 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 reading: unknown error 23 (0x17)
08/08/07 22:55:43 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 reading: unknown error 23 (0x17)
08/08/07 22:55:43 nsrd: media warning: rd=ysapprdvdb.ijnet.co.za:\\.\Tape1 reading: unknown error 23 (0x17)
08/08/07 22:55:43 nsrd: media notice: Volume "MSSQLOnline.404" on device "rd=ysapprdvdb.ijnet.co.za:\\.\Tape1": Cannot decode block. Verify the device configuration. Tape positioning by record is disabled.
08/08/07 22:55:43 nsrd: media warning: verification of volume "MSSQLOnline.404", volid 347743139 failed, can not read record 863 of file 26 on LTO Ultrium-2 tape MSSQLOnline.404
08/08/07 22:55:43 nsrd: media notice: verification of volume "MSSQLOnline.404", volid 347743139 failed, volume is being marked as full.

My problem is that if it encountered a media error and needed cleaning, or couldnt decode..shouldn’t it have just grabbed another tape from that pool?

How do I prevent this from happening again?

Thanks in advance

 

[605]

You have 2 issues:
- Your device needs cleaning or it is defect. The determination is not so easy.
The first attempt is to assume the device needs cleaning.
NW can do this automatically, if
- this option has been set
- a clenaing tape has been inserted
- and the cleaning counter has been 'loaded'

Of course this cannot really help if the device is defective.
If NW can not ecover from a write error, it will mark the media as full, preventing its further usage.
Sometimes NW may even disable the device to block further accesses as well.

- The other problem may arise due to the fact that you have "assigned devices to pools". unfortunately, customers love to do that. Now, if you only have one device assigned to the pool and NW disabled that, of course there is no other device available to help writing to this pool.
This is what you need to consider.

 

[Titann]

Hi there,

I agree with you on the first part... it did need cleaning and so it was done by networker... on the other hand i do not have any devices assigned to any pool that i have.. and that was what was so strange that it never requested another tape from that pool..

 

[605]

O.K. - if the device is not the problem, then the media. Obviously, there is no other media that can be (re)labeled for whatever purpose.

Make sure that 'Auto Media Management' for the jukebox is enabled. Also look at your media status - a tape can only be relabeled if its status is 'recyclable'. If you run out of such media, then the problem is obvious.