Hi !!
I have bacula 2.2.4 on a freeBSD 6.1.
Bacula have been upgraded from 2.0.3 version and now i have problems
with changer.
Here is an example:
15-Oct 13:36 rap-dir: Start Backup JobId 5363,
Job=srvmontuiri2-diario.2007-10-15_13.36.06
15-Oct 13:36 rap-dir: Using Device "Drive-1"
15-Oct 13:40 srvmontuiri2-fd: DIR and FD clocks differ by 255 seconds,
FD automatically adjusting.
15-Oct 13:37 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:37 rap-sd: 3995 Bad autochanger "unload slot 6, drive 0":
ERR=Child exited with code 1
Results=Unloading Data Transfer Element into Storage Element 6...mtx:
Request Sense: Long Report=yes
mtx: Request Sense: Valid Residual=no
mtx: Request Sense: Error Code=70 (Current)
mtx: Request Sense: Sense Key=Illegal Request
mtx: Request Sense: FileMark=no
mtx: Request Sense: EOM=no
mtx: Request Sense: ILI=no
mtx: Request Sense: Additional Sense Code = 53
mtx: Request Sense: Additional Sense Qualifier = 03
mtx: Request Sense: BPV=no
mtx: Request Sense: Error in CDB=no
mtx: Request Sense: SKSV=no
MOVE MEDIUM f
15-Oct 13:37 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:38 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:38 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 6.
15-Oct 13:38 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:38 rap-sd: 3995 Bad autochanger "unload slot 6, drive 0":
ERR=Child exited with code 1
Results=Unloading Data Transfer Element into Storage Element 6...mtx:
Request Sense: Long Report=yes
mtx: Request Sense: Valid Residual=no
mtx: Request Sense: Error Code=70 (Current)
mtx: Request Sense: Sense Key=Illegal Request
mtx: Request Sense: FileMark=no
mtx: Request Sense: EOM=no
mtx: Request Sense: ILI=no
mtx: Request Sense: Additional Sense Code = 53
mtx: Request Sense: Additional Sense Qualifier = 03
mtx: Request Sense: BPV=no
mtx: Request Sense: Error in CDB=no
mtx: Request Sense: SKSV=no
MOVE MEDIUM f
15-Oct 13:38 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:39 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:39 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 6.
15-Oct 13:39 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:39 rap-sd: 3995 Bad autochanger "unload slot 6, drive 0":
ERR=Child exited with code 1
Results=Unloading Data Transfer Element into Storage Element 6...mtx:
Request Sense: Long Report=yes
mtx: Request Sense: Valid Residual=no
mtx: Request Sense: Error Code=70 (Current)
mtx: Request Sense: Sense Key=Illegal Request
mtx: Request Sense: FileMark=no
mtx: Request Sense: EOM=no
mtx: Request Sense: ILI=no
mtx: Request Sense: Additional Sense Code = 53
mtx: Request Sense: Additional Sense Qualifier = 03
mtx: Request Sense: BPV=no
mtx: Request Sense: Error in CDB=no
mtx: Request Sense: SKSV=no
MOVE MEDIUM f
15-Oct 13:39 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:40 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:40 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 6.
15-Oct 13:40 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:40 rap-sd: 3995 Bad autochanger "unload slot 6, drive 0":
ERR=Child exited with code 1
Results=Unloading Data Transfer Element into Storage Element 6...mtx:
Request Sense: Long Report=yes
mtx: Request Sense: Valid Residual=no
mtx: Request Sense: Error Code=70 (Current)
mtx: Request Sense: Sense Key=Illegal Request
mtx: Request Sense: FileMark=no
mtx: Request Sense: EOM=no
mtx: Request Sense: ILI=no
mtx: Request Sense: Additional Sense Code = 53
mtx: Request Sense: Additional Sense Qualifier = 03
mtx: Request Sense: BPV=no
mtx: Request Sense: Error in CDB=no
mtx: Request Sense: SKSV=no
MOVE MEDIUM from Element Address 1 to 1006 Failed
15-Oct 13:40 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:41 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:41 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 6.
15-Oct 13:42 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:42 rap-sd: 3995 Bad autochanger "unload slot 6, drive 0":
ERR=Child exited with code 1
Results=Unloading Data Transfer Element into Storage Element 6...mtx:
Request Sense: Long Report=yes
mtx: Request Sense: Valid Residual=no
mtx: Request Sense: Error Code=70 (Current)
mtx: Request Sense: Sense Key=Illegal Request
mtx: Request Sense: FileMark=no
mtx: Request Sense: EOM=no
mtx: Request Sense: ILI=no
mtx: Request Sense: Additional Sense Code = 53
mtx: Request Sense: Additional Sense Qualifier = 03
mtx: Request Sense: BPV=no
mtx: Request Sense: Error in CDB=no
mtx: Request Sense: SKSV=no
MOVE MEDIUM from Element Address 1 to 1006 Failed
15-Oct 13:42 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:43 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:43 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 6.
15-Oct 13:43 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:44 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:44 rap-sd: 3995 Bad autochanger "unload slot 6, drive 0":
ERR=Child exited with code 1
Results=Unloading Data Transfer Element into Storage Element 6...mtx:
Request Sense: Long Report=yes
mtx: Request Sense: Valid Residual=no
mtx: Request Sense: Error Code=70 (Current)
mtx: Request Sense: Sense Key=Illegal Request
mtx: Request Sense: FileMark=no
mtx: Request Sense: EOM=no
mtx: Request Sense: ILI=no
mtx: Request Sense: Additional Sense Code = 53
mtx: Request Sense: Additional Sense Qualifier = 03
mtx: Request Sense: BPV=no
mtx: Request Sense: Error in CDB=no
mtx: Request Sense: SKSV=no
MOVE MEDIUM from Element Address 1 to 1006 Failed
15-Oct 13:44 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:45 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:45 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 6.
15-Oct 13:45 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:46 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:46 rap-sd: 3995 Bad autochanger "unload slot 6, drive 0":
ERR=Child exited with code 1
Results=Unloading Data Transfer Element into Storage Element 6...mtx:
Request Sense: Long Report=yes
mtx: Request Sense: Valid Residual=no
mtx: Request Sense: Error Code=70 (Current)
mtx: Request Sense: Sense Key=Illegal Request
mtx: Request Sense: FileMark=no
mtx: Request Sense: EOM=no
mtx: Request Sense: ILI=no
mtx: Request Sense: Additional Sense Code = 53
mtx: Request Sense: Additional Sense Qualifier = 03
mtx: Request Sense: BPV=no
mtx: Request Sense: Error in CDB=no
mtx: Request Sense: SKSV=no
MOVE MEDIUM from Element Address 1 to 1006 Failed
15-Oct 13:46 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:47 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:47 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 6.
15-Oct 13:47 rap-sd: Please mount Volume "DiarioXALOC-01" or label a new
one for:
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Storage: "Drive-1" (/dev/nsa0)
Pool: PoolDiarioXALOC
Media type: LTO2
15-Oct 13:48 rap-sd: 3307 Issuing autochanger "unload slot 6, drive 0"
command.
15-Oct 13:48 rap-sd: 3304 Issuing autochanger "load slot 10, drive 0"
command.
15-Oct 13:49 rap-sd: 3305 Autochanger "load slot 10, drive 0", status is OK.
15-Oct 13:49 rap-sd: 3301 Issuing autochanger "loaded? drive 0" command.
15-Oct 13:49 rap-sd: 3302 Autochanger "loaded? drive 0", result is Slot 10.
15-Oct 13:49 rap-sd: Volume "DiarioXALOC-01" previously written, moving
to end of data.
15-Oct 13:51 rap-sd: Ready to append to end of Volume "DiarioXALOC-01"
at file=58.
15-Oct 13:52 rap-sd: Job write elapsed time = 00:00:37, Transfer rate =
21.91 K bytes/second
15-Oct 13:52 rap-dir: Bacula rap-dir 2.2.4 (14Sep07): 15-Oct-2007 13:52:23
Build OS: i386-unknown-freebsd6.1 freebsd 6.1-RELEASE
JobId: 5363
Job: srvmontuiri2-diario.2007-10-15_13.36.06
Backup Level: Incremental, since=2007-10-10 15:00:05
Client: "srvmontuiri2-fd" 2.0.3 (06Mar07)
Linux,Cross-compile,Win32
FileSet: "FS-srvmontuiri2" 2007-03-29 15:02:54
Pool: "PoolDiarioXALOC" (From Job resource)
Storage: "MSL-2024" (From Job resource)
Scheduled time: 15-Oct-2007 13:35:55
Start time: 15-Oct-2007 13:36:12
End time: 15-Oct-2007 13:52:23
Elapsed time: 16 mins 11 secs
Priority: 10
FD Files Written: 38
SD Files Written: 38
FD Bytes Written: 805,145 (805.1 KB)
SD Bytes Written: 810,931 (810.9 KB)
Rate: 0.8 KB/s
Software Compression: 72.2 %
VSS: no
Encryption: no
Volume name(s): DiarioXALOC-01
Volume Session Id: 239
Volume Session Time: 1191573554
Last Volume Bytes: 1,592,779,019 (1.592 GB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Backup OK
15-Oct 13:52 rap-dir: Begin pruning Jobs.
15-Oct 13:52 rap-dir: No Jobs found to prune.
15-Oct 13:52 rap-dir: Begin pruning Files.
15-Oct 13:52 rap-dir: Pruned Files from 2 Jobs for client
srvmontuiri2-fd from catalog.
15-Oct 13:52 rap-dir: End auto prune.
#############################################################################################
# Libreria HP MSL 2024
Autochanger {
Name = MSL-2024
Device = Drive-1
Changer Command = "/etc/bacula/mtx-changer %c %o %S %a %d"
Changer Device = /dev/pass1
}
# Drive de la MSL (HP Ultrium LTO 2)
Device {
Name = Drive-1 #
Drive Index = 0
Media Type = LTO2
Archive Device = /dev/nsa0
Device Type = Tape
AutomaticMount = yes; # when device opened, read it
AlwaysOpen = yes;
RemovableMedia = yes;
RandomAccess = no;
AutoChanger = yes
Offline On Unmount = no
Hardware End of Medium = no
#BSF at EOM = yes
#Backward Space Record = no
#Fast Forward Space File = no
#TWO EOF = yes
}
As you can see bacula tries to change the tape whithout success. Finally
changes the tape and execute the job. Sometimes i have 5 min delay ,
sometimes i have 12 hours delay because bacula cannot mount the tape.
Finally, with verion 2.0.3, i dont have this problem. Any idea?
Thanks
--
Alberto Frontera
Técnico de Sistemas
Brújula
T. +34 971 433 909 - F. +34 971 433 910
www.brujula.es
_________________________________
En el corazón de su negocio
--
Alberto Frontera
Técnico de Sistemas
Brújula
T. +34 971 433 909 - F. +34 971 433 910
www.brujula.es
_________________________________
En el corazón de su negocio
-------------------------------------------------------------------------
This SF.net email is sponsored by: Splunk Inc.
Still grepping through log files to find problems? Stop.
Now Search log events and configuration files using AJAX and a browser.
Download your FREE copy of Splunk now >> http://get.splunk.com/
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users
