Bacula-users

Re: [Bacula-users] Error on SD despooling Attributes

2013-02-08 13:20:33
Subject: Re: [Bacula-users] Error on SD despooling Attributes
From: Diego Rubert <dprubert AT prms.mpf.gov DOT br>
Date: Fri, 08 Feb 2013 15:18:44 -0300
My spool disk has 79GB and bacula is allowed (by config) to use 70GB, despooling when it reaches this limit.
Got another error today, similar but not the same (Fatal error: bsock.c:646 fread attr spool error. ERR=Success):

07-Feb 22:05 bacula-dir JobId 16663: No prior Full backup Job record found.
07-Feb 22:05 bacula-dir JobId 16663: No prior or suitable Full backup found in catalog. Doing FULL backup.
07-Feb 22:13 bacula-dir JobId 16663: Start Backup JobId 16663, Job=bkp-prms01.2013-02-07_22.05.00_20
07-Feb 22:13 bacula-dir JobId 16663: Using Device "FileStorage"
07-Feb 22:13 bacula-sd JobId 16663: Spooling data ...
08-Feb 01:44 bacula-sd JobId 16663: User specified spool size reached.
08-Feb 01:44 bacula-sd JobId 16663: Writing spooled data to Volume. Despooling 75,161,940,828 bytes ...
08-Feb 02:03 bacula-sd JobId 16663: Despooling elapsed time = 00:18:19, Transfer rate = 68.39 M Bytes/second
08-Feb 02:03 bacula-sd JobId 16663: Spooling data again ...
08-Feb 05:19 bacula-sd JobId 16663: Committing spooled data to Volume "Vol0001". Despooling 56,734,978,561 bytes ...
08-Feb 05:32 bacula-sd JobId 16663: Despooling elapsed time = 00:13:11, Transfer rate = 71.72 M Bytes/second
08-Feb 05:32 bacula-sd JobId 16663: Elapsed time=07:19:40, Transfer rate=4.994 M Bytes/second
08-Feb 05:32 bacula-sd JobId 16663: Sending spooled attrs to the Director. Despooling 253,590,462 bytes ...
08-Feb 05:33 bacula-sd JobId 16663: Fatal error: bsock.c:646 fread attr spool error. ERR=Success
08-Feb 05:34 bacula-dir JobId 16663: Error: Bacula bacula-dir 5.2.12 (12Sep12):
  Build OS:               x86_64-suse-linux-gnu suse 11
  JobId:                  16663
  Job:                    bkp-prms01.2013-02-07_22.05.00_20
  Backup Level:           Full (upgraded from Incremental)
  Client:                 "prms01" 5.2.12 (12Sep12) x86_64-unknown-linux-gnu,suse,10
  FileSet:                "FileServer Set" 2013-02-06 22:05:00
  Pool:                   "File" (From Job resource)
  Catalog:                "MyCatalog" (From Client resource)
  Storage:                "FileStorage" (From Pool resource)
  Scheduled time:         07-Feb-2013 22:05:00
  Start time:             07-Feb-2013 22:13:15
  End time:               08-Feb-2013 05:34:49
  Elapsed time:           7 hours 21 mins 34 secs
  Priority:               10
  FD Files Written:       680,412
  SD Files Written:       680,412
  FD Bytes Written:       131,606,271,609 (131.6 GB)
  SD Bytes Written:       131,749,842,315 (131.7 GB)
  Rate:                   4967.4 KB/s
  Software Compression:   14.6 %
  VSS:                    no
  Encryption:             no
  Accurate:               no
  Volume name(s):         Vol0001
  Volume Session Id:      13
  Volume Session Time:    1360260723
  Last Volume Bytes:      514,719,307,852 (514.7 GB)
  Non-fatal FD errors:    0
  SD Errors:              1
  FD termination status:  OK
  SD termination status:  Error
  Termination:            *** Backup Error ***

Still got no clues...
--

Diego P. Rubert
Coordenadoria de Informática
Procuradoria da República no Estado de Mato Grosso do Sul
Ministério Público Federal

Em 07-02-2013 15:04, alejandro alfonso fernandez escreveu:
Hi!

Maybe the partition use for spooling has not enough size

Note, not only the "data", but the "metadata" partition can return other error:

Mysql example:
tmpdir  = /tmp/ (default)
tmpdir  = /var/tmp/mysql  (in my case, for large backups)

In your case, be sure having >255Gb for that purpose

Best regards!


On Thu, Feb 7, 2013 at 5:02 PM, Diego Rubert <dprubert AT prms.mpf.gov DOT br> wrote:
Hi,
I've got some strange error when doing a full backup with data spooling enabled (specifically when despooling attributes) and a warning "getmsg.c:176 bget_dirmsg: unknown bnet signal -169472939".
Sometimes the error appears, sometimes don't. You can see the log bellow.
Googled and found nothing...
Any ideas?
Regards,
   Diego


06-Feb 22:05 bacula-dir JobId 16599: No prior Full backup Job record found.
06-Feb 22:05 bacula-dir JobId 16599: No prior or suitable Full backup found in catalog. Doing FULL backup.
06-Feb 22:14 bacula-dir JobId 16599: Start Backup JobId 16599, Job=bkp-prms01.2013-02-06_22.05.00_17
06-Feb 22:14 bacula-dir JobId 16599: Using Device "FileStorage"
06-Feb 22:14 bacula-sd JobId 16599: Spooling data ...
07-Feb 02:25 bacula-sd JobId 16599: User specified spool size reached.
07-Feb 02:25 bacula-sd JobId 16599: Writing spooled data to Volume. Despooling 80,530,659,921 bytes ...
07-Feb 02:44 bacula-sd JobId 16599: Despooling elapsed time = 00:19:05, Transfer rate = 70.33 M Bytes/second
07-Feb 02:44 bacula-sd JobId 16599: Spooling data again ...
07-Feb 05:46 bacula-sd JobId 16599: Committing spooled data to Volume "Vol0001". Despooling 51,859,698,621 bytes ...
07-Feb 05:58 bacula-sd JobId 16599: Despooling elapsed time = 00:12:29, Transfer rate = 69.23 M Bytes/second
07-Feb 05:58 bacula-sd JobId 16599: Elapsed time=07:44:20, Transfer rate=4.746 M Bytes/second
07-Feb 05:58 bacula-sd JobId 16599: Sending spooled attrs to the Director. Despooling 253,540,559 bytes ...
07-Feb 05:58 bacula-dir JobId 16599: Warning: getmsg.c:176 bget_dirmsg: unknown bnet signal -169472939
07-Feb 06:00 bacula-dir JobId 16599: Error: Bacula bacula-dir 5.2.12 (12Sep12):
   Build OS:               x86_64-suse-linux-gnu suse 11
   JobId:                  16599
   Job:                    bkp-prms01.2013-02-06_22.05.00_17
   Backup Level:           Full (upgraded from Incremental)
   Client:                 "prms01" 5.2.12 (12Sep12) x86_64-unknown-linux-gnu,suse,10
   FileSet:                "FileServer Set" 2013-02-06 22:05:00
   Pool:                   "File" (From Job resource)
   Catalog:                "MyCatalog" (From Client resource)
   Storage:                "FileStorage" (From Pool resource)
   Scheduled time:         06-Feb-2013 22:05:00
   Start time:             06-Feb-2013 22:14:12
   End time:               07-Feb-2013 06:00:15
   Elapsed time:           7 hours 46 mins 3 secs
   Priority:               10
   FD Files Written:       680,288
   SD Files Written:       0
   FD Bytes Written:       132,099,285,441 (132.0 GB)
   SD Bytes Written:       0 (0 B)
   Rate:                   4724.1 KB/s
   Software Compression:   14.6 %
   VSS:                    no
   Encryption:             no
   Accurate:               no
   Volume name(s):         Vol0001
   Volume Session Id:      126
   Volume Session Time:    1359999227
   Last Volume Bytes:      372,117,630,887 (372.1 GB)
   Non-fatal FD errors:    0
   SD Errors:              0
   FD termination status:  OK
   SD termination status:  SD despooling Attributes
   Termination:            *** Backup Error ***



--
--

Diego P. Rubert
Coordenadoria de Informática
Procuradoria da República no Estado de Mato Grosso do Sul
Ministério Público Federal


------------------------------------------------------------------------------
Free Next-Gen Firewall Hardware Offer
Buy your Sophos next-gen firewall before the end March 2013
and get the hardware for free! Learn more.
http://p.sf.net/sfu/sophos-d2d-feb
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users

------------------------------------------------------------------------------
Free Next-Gen Firewall Hardware Offer
Buy your Sophos next-gen firewall before the end March 2013 
and get the hardware for free! Learn more.
http://p.sf.net/sfu/sophos-d2d-feb
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users
<Prev in Thread] Current Thread [Next in Thread>