Hi,

18.09.2007 20:30,, Mike Seda wrote::
> Hi All,
> I just conducted a successful restore job via bconsole, but received 
> some weird warning messages. Suspiciously, these warnings started to 
> appear after a library (robotics and drive) firmware upgrade.
> 
> The warning that I receive is:
> Warning: acquire.c:200 Read open device "Drive-1" (/dev/nst0) Volume 
> "MSR115L3" failed: ERR=dev.c:424 Unable to open device "Drive-1" 
> (/dev/nst0): ERR=Input/output error

Is it possible that, in your mtx-changer script, you use a hard-coded 
wait time after loading a tape? If that's the case, I suspect that the 
new firmware made autochanger operations take longer, and thus your 
timeout is overrun. If that's the case, you should activate the 
wait_for_drive function and use that.

If you already use that, I'd suggest to add a hard-coded wait time 
after autochanger operations, in case the new firmware makes mtx 
return even before the actual operation is finished.

Arno

> The complete restore job output is provided below:
> 18-Sep 14:02 uwharrie-dir: Start Restore Job 
> RestoreFiles.2007-09-18_14.02.42
> 18-Sep 14:02 uwharrie-sd: 3307 Issuing autochanger "unload slot 1, drive 
> 0" command.
> 18-Sep 14:03 uwharrie-sd: 3304 Issuing autochanger "load slot 11, drive 
> 0" command.
> 18-Sep 14:03 uwharrie-sd: 3305 Autochanger "load slot 11, drive 0", 
> status is OK.
> 18-Sep 14:03 uwharrie-sd: 3301 Issuing autochanger "loaded? drive 0" 
> command.
> 18-Sep 14:03 uwharrie-sd: 3302 Autochanger "loaded? drive 0", result is 
> Slot 11.
> 18-Sep 14:03 uwharrie-sd: RestoreFiles.2007-09-18_14.02.42 Warning: 
> acquire.c:200 Read open device "Drive-1" (/dev/nst0) Volume "MSR115L3" 
> failed: ERR=dev.c:424 Unable to open device "Drive-1" (/dev/nst0): 
> ERR=Input/output error
> 
> 18-Sep 14:03 uwharrie-sd: 3301 Issuing autochanger "loaded? drive 0" 
> command.
> 18-Sep 14:03 uwharrie-sd: 3302 Autochanger "loaded? drive 0", result is 
> Slot 11.
> 18-Sep 14:03 uwharrie-sd: RestoreFiles.2007-09-18_14.02.42 Warning: 
> acquire.c:200 Read open device "Drive-1" (/dev/nst0) Volume "MSR115L3" 
> failed: ERR=dev.c:424 Unable to open device "Drive-1" (/dev/nst0): 
> ERR=Input/output error
> 
> 18-Sep 14:03 uwharrie-sd: Please mount Volume "MSR115L3" on Storage 
> Device "Drive-1" (/dev/nst0) for Job RestoreFiles.2007-09-18_14.02.42
> 18-Sep 14:06 uwharrie-sd: 3301 Issuing autochanger "loaded? drive 0" 
> command.
> 18-Sep 14:06 uwharrie-sd: 3302 Autochanger "loaded? drive 0", result is 
> Slot 11.
> 18-Sep 14:06 uwharrie-sd: Ready to read from volume "MSR115L3" on device 
> "Drive-1" (/dev/nst0).
> 18-Sep 14:06 uwharrie-sd: Forward spacing Volume "MSR115L3" to 
> file:block 692:0.
> 18-Sep 14:08 uwharrie-sd: End of Volume at file 692 on device "Drive-1" 
> (/dev/nst0), Volume "MSR115L3"
> 18-Sep 14:08 uwharrie-sd: End of all volumes.
> 18-Sep 14:08 uwharrie-dir: Bacula 2.0.1 (12Jan07): 18-Sep-2007 14:08:34
>   JobId:                  2306
>   Job:                    RestoreFiles.2007-09-18_14.02.42
>   Client:                 uwharrie-fd
>   Start time:             18-Sep-2007 14:02:44
>   End time:               18-Sep-2007 14:08:34
>   Files Expected:         1
>   Files Restored:         1
>   Bytes Restored:         32,813
>   Rate:                   0.1 KB/s
>   FD Errors:              0
>   FD termination status:  OK
>   SD termination status:  OK
>   Termination:            Restore OK
> 
> I also received a similar warning message at bconsole by simply mounting 
> a different tape:
> *mount
> The defined Storage resources are:
>      1: Tape
>      2: File
> Select Storage resource (1-2): 1
> Connecting to Storage daemon Tape at uwharrie:9103 ...
> Enter autochanger slot: 1
> 3301 Issuing autochanger "loaded? drive 0" command.
> 3302 Autochanger "loaded? drive 0", result: nothing loaded.
> 3304 Issuing autochanger "load slot 1, drive 0" command.
> 3305 Autochanger "load slot 1, drive 0", status is OK.
> 3301 Issuing autochanger "loaded? drive 0" command.
> 3302 Autochanger "loaded? drive 0", result is Slot 1.
> 3901 open device failed: ERR=dev.c:424 Unable to open device "Drive-1" 
> (/dev/nst0): ERR=Input/output error
> 
> My hardware/software configuration is:
> - Dell PE 2650 (1 x 73 GB RAID 1 (OS), 1 x 1.3 TB RAID 0 (data spooling 
> partition) , 4 GB RAM, 2 GB swap)
> - Quantum PX502 (LTO-3, FC, 1-Drive)
> - RHEL 4 AS
> - Bacula 2.0.1 (Pools=Weekly, Monthly, Scratch, Migrate, Archive)
> 
> Any thoughts?
> 
> Regards,
> Mike
> 
> 
> -------------------------------------------------------------------------
> This SF.net email is sponsored by: Microsoft
> Defy all challenges. Microsoft(R) Visual Studio 2005.
> http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/
> _______________________________________________
> Bacula-users mailing list
> Bacula-users@lists.sourceforge.net
> https://lists.sourceforge.net/lists/listinfo/bacula-users

-- 
Arno Lehmann
IT-Service Lehmann
www.its-lehmann.de

-------------------------------------------------------------------------
This SF.net email is sponsored by: Microsoft
Defy all challenges. Microsoft(R) Visual Studio 2005.
http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users

Reply via email to