Bacula-users

Re: [Bacula-users] backup failure

2015-10-19 18:26:21
Subject: Re: [Bacula-users] backup failure
From: Thing <thing.thing AT gmail DOT com>
Date: Tue, 20 Oct 2015 11:24:08 +1300
8><----
    62  Full          0         0   Error    19-Oct-15 23:10 BackupCatalog
    63                0         0   Error    20-Oct-15 09:23 RestoreLocalFiles
    64          108,785    3.198 G  OK       20-Oct-15 09:45 RestoreLocalFiles
    65  Full          1    38.68 M  Error    20-Oct-15 11:12 BackupCatalog

====
*list joblog jobid=65
+----------------------------------------------------------------------------------------------------+
| LogText                                                                                              |
+----------------------------------------------------------------------------------------------------+
| warlocke-dir JobId 65: shell command: run BeforeJob "/etc/bacula/scripts/make_catalog_backup.pl MyCatalog"
 |
| warlocke-dir JobId 65: Start Backup JobId 65, Job=BackupCatalog.2015-10-20_11.11.52_04
              |
| warlocke-dir JobId 65: Using Device "FileStorage"
                                                   |
| warlocke-sd JobId 65: Volume "Local-0001" previously written, moving to end of data.
                |
| warlocke-sd JobId 65: Ready to append to end of Volume "Local-0001" size=5908984571
                 |
| warlocke-sd JobId 65: Job write elapsed time = 00:00:01, Transfer rate = 38.68 M Bytes/second
       |
| warlocke-dir JobId 65: Bacula warlocke-dir 5.2.6 (21Feb12):
  Build OS:               arm-unknown-linux-gnueabihf debian 7.0
  JobId:                  65
  Job:                    BackupCatalog.2015-10-20_11.11.52_04
  Backup Level:           Full
  Client:                 "warlocke-fd" 5.2.6 (21Feb12) arm-unknown-linux-gnueabihf,debian,7.0
  FileSet:                "Catalog" 2015-10-20 11:11:52
  Pool:                   "File" (From Job resource)
  Catalog:                "MyCatalog" (From Client resource)
  Storage:                "File" (From Job resource)
  Scheduled time:         20-Oct-2015 11:11:50
  Start time:             20-Oct-2015 11:12:04
  End time:               20-Oct-2015 11:12:05
  Elapsed time:           1 sec
  Priority:               11
  FD Files Written:       1
  SD Files Written:       1
  FD Bytes Written:       38,689,048 (38.68 MB)
  SD Bytes Written:       38,689,163 (38.68 MB)
  Rate:                   38689.0 KB/s
  Software Compression:   None
  VSS:                    no
  Encryption:             no
  Accurate:               no
  Volume name(s):         Local-0001
  Volume Session Id:      33
  Volume Session Time:    1444076755
  Last Volume Bytes:      5,947,702,852 (5.947 GB)
  Non-fatal FD errors:    0
  SD Errors:              0
  FD termination status:  OK
  SD termination status:  OK
  Termination:            Backup OK

 |
| warlocke-dir JobId 65: Begin pruning Jobs older than 6 months .
                                     |
| warlocke-dir JobId 65: No Jobs found to prune.
                                                      |
| warlocke-dir JobId 65: Begin pruning Files.
                                                         |
| warlocke-dir JobId 65: No Files found to prune.
                                                     |
| warlocke-dir JobId 65: End auto prune.

                                                             |
| warlocke-dir JobId 65: shell command: run AfterJob "/etc/bacula/scripts/delete_catalog_backup"
      |
| warlocke-dir JobId 65: Error: Runscript: AfterJob returned non-zero status=200. ERR=Permission denied
 |
+----------------------------------------------------------------------------------------------------+
+-------+---------------+---------------------+------+-------+----------+------------+-----------+
| JobId | Name          | StartTime           | Type | Level | JobFiles | JobBytes   | JobStatus |
+-------+---------------+---------------------+------+-------+----------+------------+-----------+
|    65 | BackupCatalog | 2015-10-20 11:12:04 | B    | F     |        1 | 38,689,048 | T         |
+-------+---------------+---------------------+------+-------+----------+------------+-----------+
*
8><-----

This looks better?



On 20 October 2015 at 11:11, Thing <thing.thing AT gmail DOT com> wrote:
ah,

8><----
# This is the backup of the catalog
FileSet {
  Name = "Catalog"
  Include {
    Options {
      signature = MD5
    }
    File = "/var/lib/bacula/.sql"
  }
}

# Client (File Services) to backup
=====
8><-----

so .sql should be bacula.sql I assume?


permissions.....hmm, will take a look....

On 20 October 2015 at 10:59, Ana Emília M. Arruda <emiliaarruda AT gmail DOT com> wrote:
​Hello Thing,

Please check the FileSet for your BackupCatalog job. ​The job cannot find the MySQL dump (bacula.sql) at your working directory /var/lib/bacula.

Your FileSet must include this file:

FileSet {
  Name = "CatalogFileSet"
  Include {
    Options {
      signature = MD5
    }
    File = /var/lib/bacula/bacula.sql
  }
}

Also, the delete_catalog_backup script do not have the necessary permissions to run. If you´re running the script as "bacula" user for example, you must set the necessary permissions for this user to run the script.

| warlocke-dir JobId 62: shell command: run AfterJob "/etc/bacula/scripts/delete_catalog_backup"
      |
| warlocke-dir JobId 62: Error: Runscript: AfterJob returned non-zero status=200. ERR=Permission denied

Best regards,
Ana


On Mon, Oct 19, 2015 at 6:42 PM, Thing <thing.thing AT gmail DOT com> wrote:
*list joblog jobid=62
+----------------------------------------------------------------------------------------------------+
| LogText                                                                                              |
+----------------------------------------------------------------------------------------------------+
| warlocke-dir JobId 62: shell command: run BeforeJob "/etc/bacula/scripts/make_catalog_backup.pl MyCatalog"
 |
| warlocke-dir JobId 62: Start Backup JobId 62, Job=BackupCatalog.2015-10-19_23.10.00_39
              |
| warlocke-dir JobId 62: Using Device "FileStorage"
                                                   |
| warlocke-sd JobId 62: Volume "Local-0001" previously written, moving to end of data.
                |
| warlocke-sd JobId 62: Ready to append to end of Volume "Local-0001" size=5908984169
                 |
| warlocke-fd JobId 62:      Could not stat "/var/lib/bacula/.sql": ERR=No such file or directory
     |
| warlocke-sd JobId 62: Job write elapsed time = 00:00:01, Transfer rate = 0  Bytes/second
            |
| warlocke-dir JobId 62: Bacula warlocke-dir 5.2.6 (21Feb12):
  Build OS:               arm-unknown-linux-gnueabihf debian 7.0
  JobId:                  62
  Job:                    BackupCatalog.2015-10-19_23.10.00_39
  Backup Level:           Full
  Client:                 "warlocke-fd" 5.2.6 (21Feb12) arm-unknown-linux-gnueabihf,debian,7.0
  FileSet:                "Catalog" 2015-09-27 23:10:00
  Pool:                   "File" (From Job resource)
  Catalog:                "MyCatalog" (From Client resource)
  Storage:                "File" (From Job resource)
  Scheduled time:         19-Oct-2015 23:10:00
  Start time:             19-Oct-2015 23:10:11
  End time:               19-Oct-2015 23:10:12
  Elapsed time:           1 sec
  Priority:               11
  FD Files Written:       0
  SD Files Written:       0
  FD Bytes Written:       0 (0 B)
  SD Bytes Written:       0 (0 B)
  Rate:                   0.0 KB/s
  Software Compression:   None
  VSS:                    no
  Encryption:             no
  Accurate:               no
  Volume name(s):        
  Volume Session Id:      31
  Volume Session Time:    1444076755
  Last Volume Bytes:      5,908,984,571 (5.908 GB)
  Non-fatal FD errors:    1
  SD Errors:              0
  FD termination status:  OK
  SD termination status:  OK
  Termination:            Backup OK -- with warnings

 |
| warlocke-dir JobId 62: Begin pruning Jobs older than 6 months .
                                     |
| warlocke-dir JobId 62: No Jobs found to prune.
                                                      |
| warlocke-dir JobId 62: Begin pruning Files.
                                                         |
| warlocke-dir JobId 62: No Files found to prune.
                                                     |
| warlocke-dir JobId 62: End auto prune.

                                                             |
| warlocke-dir JobId 62: shell command: run AfterJob "/etc/bacula/scripts/delete_catalog_backup"
      |
| warlocke-dir JobId 62: Error: Runscript: AfterJob returned non-zero status=200. ERR=Permission denied
 |
+----------------------------------------------------------------------------------------------------+
+-------+---------------+---------------------+------+-------+----------+----------+-----------+
| JobId | Name          | StartTime           | Type | Level | JobFiles | JobBytes | JobStatus |
+-------+---------------+---------------------+------+-------+----------+----------+-----------+
|    62 | BackupCatalog | 2015-10-19 23:10:11 | B    | F     |        0 |        0 | T         |
+-------+---------------+---------------------+------+-------+----------+----------+-----------+
*


On 20 October 2015 at 10:04, Ana Emília M. Arruda <emiliaarruda AT gmail DOT com> wrote:
Hello Thing,

Could you post the log for any of your BackupCatalog job that runs into error? From bconsole:

list joblog jobid=62

Best regards,
Ana

On Mon, Oct 19, 2015 at 5:52 PM, Thing <thing.thing AT gmail DOT com> wrote:

Hi,


I have a catalogue backup error.


=========

Enter a period to cancel a command.
*status
Status available for:
     1: Director
     2: Storage
     3: Client
     4: All
Select daemon type for status (1-4): 1
warlocke-dir Version: 5.2.6 (21 February 2012) arm-unknown-linux-gnueabihf debian 7.0
Daemon started 06-Oct-15 09:26. Jobs: run=32, running=0 mode=0,0
 Heap: heap=405,504 smbytes=92,543 max_bytes=9,929,949 bufs=288 max_bufs=1,227

Scheduled Jobs:
Level          Type     Pri  Scheduled          Name               Volume
===================================================================================
Incremental    Backup    10  20-Oct-15 23:05    BackupLocalFiles   Local-0001
Full           Backup    11  20-Oct-15 23:10    BackupCatalog      Local-0001
====

Running Jobs:
Console connected at 09-Oct-15 15:49
Console connected at 20-Oct-15 09:21
Console connected at 20-Oct-15 09:28
No Jobs running.
====

Terminated Jobs:
 JobId  Level    Files      Bytes   Status   Finished        Name
====================================================================
    54  Incr        866    48.24 M  OK       16-Oct-15 23:06 BackupLocalFiles
    55  Full          0         0   Error    16-Oct-15 23:10 BackupCatalog
    56  Incr        521    37.50 M  OK       17-Oct-15 23:06 BackupLocalFiles
    57  Full          0         0   Error    17-Oct-15 23:10 BackupCatalog
    58  Diff      6,082    185.8 M  OK       18-Oct-15 23:09 BackupLocalFiles
    59  Full          0         0   Error    18-Oct-15 23:10 BackupCatalog
    60           92,720    2.814 G  OK       19-Oct-15 16:00 RestoreLocalFiles
    61  Incr      5,176    62.35 M  OK       19-Oct-15 23:08 BackupLocalFiles
    62  Full          0         0   Error    19-Oct-15 23:10 BackupCatalog
    63                0         0   Error    20-Oct-15 09:23 RestoreLocalFiles

====
*

========


Does the catalogue failure matter? I assume it does....


Backups seem OK, just doing a test restore.




regards

Steven


------------------------------------------------------------------------------

_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users




------------------------------------------------------------------------------

_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users




------------------------------------------------------------------------------
_______________________________________________
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>