Hi people.
I have been having problems with bacula and my tape drive, this
weekend my Full Backup request me another tape, saying that my current
tape was FULL.
This is my log from the last good job last week:
************************************************************************************************************************************************
08-Jan 02:00 bacula-dir JobId 2645: BeforeJob: run command
"/usr/local/share/bacula/make_catalog_backup bacula bacula"
08-Jan 02:06 bacula-dir JobId 2645: Start Backup JobId 2645,
Job=BackupCatalog.2008-01-08_02.00.27
08-Jan 02:06 bacula-dir JobId 2645: Using Device "StorageWorks-232"
08-Jan 02:08 bacula-sd JobId 2645: Job write elapsed time = 00:02:10,
Transfer rate = 11.24 M bytes/second
08-Jan 02:08 bacula-dir JobId 2645: Bacula bacula-dir 2.2.5 (09Oct07):
08-Jan-2008 02:08:18
Build OS: i386-portbld-freebsd6.1 freebsd 6.1-RELEASE-p16
JobId: 2645
Job: BackupCatalog.2008-01-08_02.00.27
Backup Level: Full
Client: "BACULA" 2.2.5 (09Oct07)
i386-portbld-freebsd6.1,freebsd,6.1-RELEASE-p16
FileSet: "CATALOG-FS" 2006-08-22 05:00:02
Pool: "MueblexFullTape" (From Job resource)
Storage: "LTO-1" (From Job resource)
Scheduled time: 08-Jan-2008 02:00:00
Start time: 08-Jan-2008 02:06:03
End time: 08-Jan-2008 02:08:18
Elapsed time: 2 mins 15 secs
Priority: 25
FD Files Written: 7,645
SD Files Written: 7,645
FD Bytes Written: 1,460,551,199 (1.460 GB)
SD Bytes Written: 1,461,438,932 (1.461 GB)
Rate: 10818.9 KB/s
Software Compression: None
VSS: no
Encryption: no
Volume name(s): FullTape-0015
Volume Session Id: 9
Volume Session Time: 1199720166
Last Volume Bytes: 129,456,165,888 (129.4 GB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Backup OK
************************************************************************************************************************************************
You can see the amount of data that we add to that tape.
Now look this last job:
14-Jan 08:55 bacula-dir JobId 2670: Start Backup JobId 2670,
Job=MBXBDCB.2008-01-14_00.30.13
14-Jan 08:55 bacula-dir JobId 2670: Using Device "StorageWorks-232"
14-Jan 10:35 bacula-sd JobId 2670: End of Volume "FullTape-0012" at
74:1 on device "StorageWorks-232" (/dev/nsa0). Write of 64
14-Jan 10:36 bacula-sd JobId 2670: End of medium on Volume
"FullTape-0012" Bytes=70,850,884,608 Blocks=1,098,258 at 14-Jan-200
14-Jan 10:36 bacula-dir JobId 2670: Warning: SQL failed, but ignored.
ERR=Query failed: SELECT MAX(MediaId) FROM Media,POOL WHERE
Pool.PoolId=2: ERR=Table 'bacula.POOL' doesn't exist
14-Jan 10:36 bacula-dir JobId 2670: Created new Volume "FullTape-0024"
in catalog.
14-Jan 10:36 bacula-sd JobId 2670: Please mount Volume "FullTape-0024"
or label a new one for:
Job: MBXBDCB.2008-01-14_00.30.13
Storage: "StorageWorks-232" (/dev/nsa0)
Pool: MueblexFullTape
Media type: LTO-1
14-Jan 10:46 bacula-sd JobId 2670: Warning: Director wanted Volume
"FullTape-0024".
Current Volume "FullTape-0012" not acceptable because:
1998 Volume "FullTape-0012" status is Full, but should be Append,
Purged or Recycle.
14-Jan 12:00 MBXBDCB-FD: MBXBDCB.2008-01-14_00.30.13 Fatal error:
backup.c:892 Network send error to SD. ERR=Input/output erro
14-Jan 10:46 bacula-sd JobId 2670: Please mount Volume "FullTape-0024"
or label a new one for:
Job: MBXBDCB.2008-01-14_00.30.13
Storage: "StorageWorks-232" (/dev/nsa0)
Pool: MueblexFullTape
Media type: LTO-1
---------------------------------------
NOTE: End of Medium 74:1
---------------------------------------
.
.
.
14-Jan 10:46 bacula-sd JobId 2670: Job MBXBDCB.2008-01-14_00.30.13
marked to be canceled.
14-Jan 10:46 bacula-sd JobId 2670: Fatal error: Job 2670 canceled.
14-Jan 10:46 bacula-sd JobId 2670: Job write elapsed time = 01:51:44,
Transfer rate = 2.980 M bytes/second
14-Jan 10:46 bacula-sd JobId 2670: Fatal error: askdir.c:332 NULL
Volume name. This shouldn't happen!!!
14-Jan 10:46 bacula-dir JobId 2670: Bacula bacula-dir 2.2.5 (09Oct07):
14-Jan-2008 10:46:58
Build OS: i386-portbld-freebsd6.1 freebsd 6.1-RELEASE-p16
JobId: 2670
Job: MBXBDCB.2008-01-14_00.30.13
Backup Level: Full
Client: "MBXBDCB" 2.2.4 (14Sep07)
i686-redhat-linux-gnu,redhat,
FileSet: "MBXBDCB-FS" 2007-12-27 18:00:00
Pool: "MueblexFullTape" (From Job resource)
Storage: "LTO-1" (From Job resource)
Scheduled time: 14-Jan-2008 00:30:00
Start time: 14-Jan-2008 08:55:13
End time: 14-Jan-2008 10:46:58
Elapsed time: 1 hour 51 mins 45 secs
Priority: 13
FD Files Written: 81,299
SD Files Written: 81,298
FD Bytes Written: 19,972,236,726 (19.97 GB)
SD Bytes Written: 19,983,200,972 (19.98 GB)
Rate: 2978.7 KB/s
Software Compression: None
VSS: no
Encryption: no
Volume name(s): FullTape-0012
Volume Session Id: 35
Volume Session Time: 1199720166
Last Volume Bytes: 0 (0 B)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: Canceled
SD termination status: Canceled
Termination: Backup Canceled
I had to cancel the next 2 jobs.
My drive have the compression by HW(I think):
bacula# mt -f /dev/nsa0 status
Mode Density Blocksize bpi Compression
Current: 0x40 variable 0 0x1
---------available modes---------
0: 0x40 variable 0 0x1
1: 0x40 variable 0 0x1
2: 0x40 variable 0 0x1
3: 0x40 variable 0 0x1
---------------------------------
Current Driver State: at rest.
---------------------------------
File Number: 0 Record Number: 0 Residual Count 0
Last week i remove 1 server from the list we save 16GB of data, i
disable the compression in all my clients 2 week ago, u can see my the
last job from last week:
Volume Session Time: 1199720166
Last Volume Bytes: 129,456,165,888 (129.4 GB)
Now this weekend:
14-Jan 10:35 bacula-sd JobId 2670: End of Volume "FullTape-0012" at
74:1 on device "StorageWorks-232" (/dev/nsa0). Write of 64
14-Jan 10:36 bacula-sd JobId 2670: End of medium on Volume
"FullTape-0012" Bytes=70,850,884,608 Blocks=1,098,258 at 14-Jan-200
Went i run the Fill command inside btape i get:
End of tape: 91:0
Volume capacity 61,155,311,616k
I think this was with compression enable.
Now without compression:
End of tape 88:12015
Volume capacity 60,642,247,680k
Last job: 74:1 70,850,884,608
I run the query command inside bacula and just 1 of my volumes show
errors i already remove that volume.
>From last week to this week my servers didn't receive different amount of data.
This problem can be tape, bacula or my drive or my tape is really FULL?
Running bacula 2.2.5(i update the server to 2.2.7 today) on FreeBSD 6.1-p21.
Thanks!!!
-------------------------------------------------------------------------
Check out the new SourceForge.net Marketplace.
It's the best place to buy or sell services for
just about anything Open Source.
http://ad.doubleclick.net/clk;164216239;13503038;w?http://sf.net/marketplace
_______________________________________________
Bacula-users mailing list
Bacula-users@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/bacula-users
