Hello, On 6/28/2006 11:23 AM, Christoff Buch wrote: > > Hello Users! > > I hope someone with autochanger expierience can help me with my > concerns.... > First of all my environment: > > - bacula 1.38.9 (from source) > - mtx 1.2.18rel (from rpm) > - SuSE 9.0 Kernel 2.4.21-99 > - Exabyte 221L TapeLibrary (21 slots in 3 Magazines, Barcodereader, 1 > IBM Ultrium LTO-2 drive)
First question: btape tests? > I don't think problem is in configure-options nor in bacula-xxx.confs > since backups succeed. So none of them here. > I just get those strange statements in log over and over again, and I'm > not sure wether someday this may lead to a crash. > Concerning the "Bad autochanger loaded drive 0 command" I guess it > might be a timing problem, but can't decide wether it's the mtx-changer > or bacula itself. Do you know anything? > (I'll add my mtx-changer) I can't read it as it claims to be a .doc file and I'm too lazy to read list mail in other formats than ASCII ;-) I think two things are most likely the reason for your problems: Configuration (use btape and post the SD config) and mtx-changer, especially concerning timing of autoloader operations. Arno > Concerning the "Unloading / Reloading tape for follow-up job": Just > why??? It's just sometimes happening, not each time! > > Today both happened in once, so here is the part of my log: > > JobId: 155 > Job: Job1_____________.2006-06-27_22.12.15 > Backup Level: Full > Client: "Client1" Windows Server 2003,MVS,NT 5.2.3790 > FileSet: "FileSet1" 2006-06-13 20:16:29 > Pool: "Daily" > Storage: "TapeLibrary" > Scheduled time: 27-Jun-2006 22:12:10 > Start time: 27-Jun-2006 22:12:20 > End time: 28-Jun-2006 00:55:04 > Elapsed time: 2 hours 42 mins 44 secs > Priority: 10 > FD Files Written: 3,903 > SD Files Written: 3,903 > FD Bytes Written: 122,954,473,051 (122.9 GB) > SD Bytes Written: 122,955,147,172 (122.9 GB) > Rate: 12592.6 KB/s > Software Compression: None > Volume name(s): TUE001L2 > Volume Session Id: 1 > Volume Session Time: 1151424310 > Last Volume Bytes: 123,046,455,465 (123.0 GB) > Non-fatal FD errors: 0 > SD Errors: 0 > FD termination status: OK > SD termination status: OK > Termination: Backup OK > > 28-Jun 00:55 heem-dir: Begin pruning Jobs. > 28-Jun 00:55 heem-dir: No Jobs found to prune. > 28-Jun 00:55 heem-dir: Begin pruning Files. > 28-Jun 00:55 heem-dir: No Files found to prune. > 28-Jun 00:55 heem-dir: End auto prune. > > 28-Jun 00:55 heem-dir: Start Backup JobId 156, > Job2_________.2006-06-27_23.00.00 > *28-Jun 00:55 heem-sd: 3301 Issuing autochanger "loaded drive 0" command.* > *28-Jun 00:55 heem-sd: 3991 Bad autochanger "loaded drive 0" command: > ERR=Operation not permitted.* > 28-Jun 00:55 heem-sd: 3301 Issuing autochanger "loaded drive 0" command. > 28-Jun 00:55 heem-sd: 3302 Autochanger "loaded drive 0", result is Slot 3. > *28-Jun 00:55 heem-sd: 3307 Issuing autochanger "unload slot 3, drive 0" > command.* > *28-Jun 00:55 heem-sd: 3304 Issuing autochanger "load slot 3, drive 0" > command.* > 28-Jun 00:56 heem-sd: 3305 Autochanger "load slot 3, drive 0", status is > OK. > 28-Jun 00:56 heem-sd: 3301 Issuing autochanger "loaded drive 0" command. > 28-Jun 00:56 heem-sd: 3302 Autochanger "loaded drive 0", result is Slot 3. > 28-Jun 00:56 heem-sd: Volume "TUE001L2" previously written, moving to > end of data. > 28-Jun 00:56 heem-sd: Ready to append to end of Volume "TUE001L2" at > file=124. > 28-Jun 01:52 heem-dir: Bacula 1.38.9 (02May06): 28-Jun-2006 01:52:29 > JobId: 156 > Job: Job2_________.2006-06-27_23.00.00 > Backup Level: Full > Client: "Client2" i686-pc-linux-gnu,suse,9.0 > FileSet: "FileSet2" 2006-06-15 00:45:31 > Pool: "Daily" > Storage: "TapeLibrary" > Scheduled time: 27-Jun-2006 23:00:00 > Start time: 28-Jun-2006 00:55:08 > End time: 28-Jun-2006 01:52:29 > Elapsed time: 57 mins 21 secs > Priority: 10 > FD Files Written: 110,844 > SD Files Written: 110,844 > FD Bytes Written: 28,747,087,799 (28.74 GB) > SD Bytes Written: 28,768,112,206 (28.76 GB) > Rate: 8354.3 KB/s > Software Compression: None > Volume name(s): TUE001L2 > Volume Session Id: 2 > Volume Session Time: 1151424310 > Last Volume Bytes: 151,839,027,155 (151.8 GB) > Non-fatal FD errors: 0 > SD Errors: 0 > FD termination status: OK > SD termination status: OK > Termination: Backup OK > > In the 3rd job, bacula doesen't repeat the "loaded drive 0" command even > though it gets an "ERR...". > But this time at least it doesn't unload/load the tape but goes on > immediately. (see below) > I don't understand this behaviour. > > 28-Jun 01:52 heem-dir: Start Backup JobId 157, > Job3________.2006-06-28_00.10.01 > 28-Jun 01:52 heem-sd: 3301 Issuing autochanger "loaded drive 0" command. > 28-Jun 01:52 heem-sd: 3302 Autochanger "loaded drive 0", result is Slot 3. > *28-Jun 01:52 heem-sd: 3301 Issuing autochanger "loaded drive 0" command.* > *28-Jun 01:52 heem-sd: 3991 Bad autochanger "loaded drive 0" command: > ERR=Operation not permitted.* > *28-Jun 01:52 heem-sd: Volume "TUE001L2" previously written, moving to > end of data.* > *28-Jun 01:53 heem-sd: Ready to append to end of Volume "TUE001L2" at > file=153.* > 28-Jun 02:32 heem-dir: Bacula 1.38.9 (02May06): 28-Jun-2006 02:32:50 > ..... > > > > > Thanks in advance! > > Best Regards, > > i. A. Christoff Buch > > ===================================== > [EMAIL PROTECTED] > +49.941.78004.607 > > [EMAIL PROTECTED] > OneVision Software AG > Dr.-Leo-Ritter-Str. 9 > D - 93049 Regensburg > > > ------------------------------------------------------------------------ > > Using Tomcat but need to do more? Need to support web services, security? > Get stuff done quickly with pre-integrated technology to make your job easier > Download IBM WebSphere Application Server v.1.0.1 based on Apache Geronimo > http://sel.as-us.falkag.net/sel?cmd=lnk&kid=120709&bid=263057&dat=121642 > > > ------------------------------------------------------------------------ > > _______________________________________________ > Bacula-users mailing list > Bacula-users@lists.sourceforge.net > https://lists.sourceforge.net/lists/listinfo/bacula-users -- IT-Service Lehmann [EMAIL PROTECTED] Arno Lehmann http://www.its-lehmann.de Using Tomcat but need to do more? Need to support web services, security? Get stuff done quickly with pre-integrated technology to make your job easier Download IBM WebSphere Application Server v.1.0.1 based on Apache Geronimo http://sel.as-us.falkag.net/sel?cmd=lnk&kid=120709&bid=263057&dat=121642 _______________________________________________ Bacula-users mailing list Bacula-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/bacula-users