Bacula-users

Re: [Bacula-users] Running Multiple Jobs at once

2012-08-03 10:30:24
Subject: Re: [Bacula-users] Running Multiple Jobs at once
From: dweimer <dweimer AT dweimer DOT net>
To: bacula-users <bacula-users AT lists.sourceforge DOT net>
Date: Fri, 03 Aug 2012 09:27:30 -0500
On 2012-08-02 15:13, John Drescher wrote:

>
> Do you see anything in the log or messages (bconsole mes command) 
> when
> this happens?
>
> Also the output of status client, status storage and status dir can
> help us debug this.
>
>>
>> Since I didn't think to mention versions before:
>> The backup server, (one test client is the backup server itself) is
>> running FreeBSD 9.0-RELEASE-P3, with bacula 5.2.10, the file daemon 
>> of
>> course is 5.2.10 as well both built from the FreeBSD ports system.
>> Server is hitting a PostgreSQL 9.1.4 database backend for the 
>> catalog
>> (is there possibly anything limiting jobs writing to catalog at once
>> that I am missing).  second client is actually a FreeNAS 
>> 8.2-RELEASE-P1
>> with bacula-fd running in a plugin jail on version 5.2.6 compiled 
>> from
>> the FreeBSD 8.2 ports system within that jail.
>
> I do not believe this version will cause you any problems. I am now
> using 5.2.10 but I am not using freebsd however I have been using
> concurrent jobs for 6 or so years and quite a few bacula versions...
>

Here is the outputs you requested, I can't spot anything that appears 
to be the problem myself, so someone else hopefully will.

bconsole screen while starting jobs:
*run
Automatically selected Catalog: MyCatalog
Using Catalog "MyCatalog"
A job name must be specified.
The defined Job resources are:
      1: webmail-Backup
      2: BackupCatalog
      3: RestoreFiles
      4: FreeNAS-Backup
      5: Workstation-VirtualMachines
Select Job resource (1-5): 1
Run Backup job
JobName:  webmail-Backup
Level:    Incremental
Client:   webmail.dweimer.local-fd
FileSet:  Snapshot
Pool:     File (From Job resource)
Storage:  File (From Job resource)
When:     2012-08-03 08:31:51
Priority: 10
OK to run? (yes/mod/no): yes
Job queued. JobId=730
*run
A job name must be specified.
The defined Job resources are:
      1: webmail-Backup
      2: BackupCatalog
      3: RestoreFiles
      4: FreeNAS-Backup
      5: Workstation-VirtualMachines
Select Job resource (1-5): 4
Run Backup job
JobName:  FreeNAS-Backup
Level:    Incremental
Client:   freenasp.dweimer.local-fd
FileSet:  FreeNAS
Pool:     File (From Job resource)
Storage:  File (From Job resource)
When:     2012-08-03 08:32:00
Priority: 10
OK to run? (yes/mod/no): yes
Job queued. JobId=731
You have messages.

status of Dir when jobs were running:
status dir
webmail.dweimer.local-dir Version: 5.2.10 (28 June 2012) 
amd64-portbld-freebsd9.0 freebsd 9.0-RELEASE-p3
Daemon started 31-Jul-12 19:47. Jobs: run=24, running=2 mode=0,0
  Heap: heap=0 smbytes=248,720 max_bytes=289,015 bufs=702 max_bufs=884

Scheduled Jobs:
Level          Type     Pri  Scheduled          Name               
Volume
===================================================================================
Incremental    Backup    10  03-Aug-12 23:30    webmail-Backup     BV12
Incremental    Backup    10  03-Aug-12 23:30    
Workstation-VirtualMachines BV12
Incremental    Backup    10  03-Aug-12 23:30    FreeNAS-Backup     BV12
Full           Backup    11  03-Aug-12 23:45    BackupCatalog      BV12
====

Running Jobs:
Console connected at 03-Aug-12 08:31
Console connected at 03-Aug-12 08:34
  JobId Level   Name                       Status
======================================================================
    730 Increme  webmail-Backup.2012-08-03_08.31.53_26 is running
    731 Increme  FreeNAS-Backup.2012-08-03_08.32.04_27 is waiting 
execution


Status of Storage While Jobs Were Running (ignore time difference, ran 
jobs a second time after forgetting this one):
*status storage
Automatically selected Storage: File
Connecting to Storage daemon File at webmail.dweimer.local:9103

File Version: 5.2.10 (28 June 2012) amd64-portbld-freebsd9.0 freebsd 
9.0-RELEASE-p3
Daemon started 02-Aug-12 12:00. Jobs: run=8, running=0.
  Heap: heap=0 smbytes=170,208 max_bytes=170,208 bufs=109 max_bufs=110
  Sizes: boffset_t=8 size_t=8 int32_t=4 int64_t=8 mode=0,0

Running Jobs:
Writing: Incremental Backup job webmail-Backup JobId=732 Volume="BV12"
     pool="File" device="FileStorage" (/mnt/bacula/eSATA)
     spooling=0 despooling=0 despool_wait=0
     Files=0 Bytes=0 Bytes/sec=0
     FDReadSeqNo=5 in_msg=4 out_msg=3 fd=6
====

Jobs waiting to reserve a drive:
====

Terminated Jobs:
  JobId  Level    Files      Bytes   Status   Finished        Name
===================================================================
    722  Incr     56,858    6.286 G  OK       02-Aug-12 11:27 
webmail-Backup
    723  Incr          2    2.440 K  OK       02-Aug-12 11:28 
FreeNAS-Backup
    724  Incr      1,510    3.120 G  OK       02-Aug-12 12:16 
webmail-Backup
    725  Incr          2    2.440 K  OK       02-Aug-12 12:16 
FreeNAS-Backup
    726  Incr     18,596    3.961 G  OK       02-Aug-12 23:46 
webmail-Backup
    727  Incr          2    2.440 K  OK       02-Aug-12 23:47 
FreeNAS-Backup
    728  Incr         81    18.35 G  OK       03-Aug-12 00:13 
Workstation-VirtualMachines
    729  Full          1    619.4 M  OK       03-Aug-12 00:14 
BackupCatalog
    730  Incr     53,106    5.242 G  OK       03-Aug-12 08:52 
webmail-Backup
    731  Incr         28    3.913 M  OK       03-Aug-12 08:54 
FreeNAS-Backup
====

Device status:
Device "FileStorage" (/mnt/bacula/eSATA) is not open.
====

Used Volume status:
BV12 on device "FileStorage" (/mnt/bacula/eSATA)
     Reader=0 writers=0 devres=1 volinuse=1


Status of first Client, no files have been sent yet, still on prejob 
script:
status client="webmail.dweimer.local-fd"
Connecting to Client webmail.dweimer.local-fd at webmail:9102

webmail.dweimer.local-fd Version: 5.2.10 (28 June 2012)  
amd64-portbld-freebsd9.0 freebsd 9.0-RELEASE-p3
Daemon started 31-Jul-12 20:09. Jobs: run=10 running=0.
  Heap: heap=0 smbytes=108,629 max_bytes=1,062,223 bufs=105 
max_bufs=3,272
  Sizeof: boffset_t=8 size_t=8 debug=0 trace=0
Running Jobs:
JobId 730 Job webmail-Backup.2012-08-03_08.31.53_26 is running.
     Incremental System or Console Job started: 03-Aug-12 08:31
Files=0 Bytes=0 Bytes/sec=0 Errors=0

     Files Examined=0
     SDReadSeqNo=3 fd=5
Director connected at: 03-Aug-12 08:32

Status of second Client (just waiting for the dir to tell it to do 
something):
status client="freenasp.dweimer.local-fd"
Connecting to Client freenasp.dweimer.local-fd at 
freenasp.dweimer.local:9102

freenasp.dweimer.local-fd Version: 5.2.6 (21 February 2012)  
amd64-portbld-freebsd8.2 freebsd 8.2-RELEASE-p9
Daemon started 24-Jul-12 03:34. Jobs: run=14 running=0.
  Heap: heap=0 smbytes=98,304 max_bytes=239,556 bufs=82 max_bufs=191
  Sizeof: boffset_t=8 size_t=8 debug=0 trace=0
Running Jobs:
Director connected at: 03-Aug-12 13:34
No Jobs running.

Full console log  from each backup:
Client 1 log:
2012-08-03 08:31:55   webmail.dweimer.local-dir JobId 730: Start Backup 
JobId 730, Job=webmail-Backup.2012-08-03_08.31.53_26
2012-08-03 08:31:55   webmail.dweimer.local-dir JobId 730: Using Device 
"FileStorage"
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: shell 
command: run ClientRunBeforeJob "/root/bacula/before.sh"
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Create PostgreSQL Backup...
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Getting Database List
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Dump Global DB Roles
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Dump Databases
2012-08-03 08:31:56   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for bacula
2012-08-03 08:33:59   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for dweimer_net
2012-08-03 08:35:18   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for dwwoodworker_net
2012-08-03 08:35:18   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for myhostinghome
2012-08-03 08:35:18   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for oroundcubemail
2012-08-03 08:35:19   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for postgres
2012-08-03 08:35:19   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for roundcubemail
2012-08-03 08:35:20   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ..Dumping Data for template1
2012-08-03 08:35:20   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:35:20   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: DumpAll
2012-08-03 08:38:29   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:38:29   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: cleanup Old IP Cam Images...
2012-08-03 08:41:21   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Done Cleaning Up Old IP Cam Images...
2012-08-03 08:41:21   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:41:21   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:41:21   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Creating Snapshots...
2012-08-03 08:41:21   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:41:21   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Snapshoting /...
2012-08-03 08:41:32   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../ Snapshot Created...
2012-08-03 08:41:32   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:41:32   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Snapshoting /usr/...
2012-08-03 08:42:24   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../usr/ Snapshot Created...
2012-08-03 08:42:24   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:42:24   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Snapshoting /var/...
2012-08-03 08:42:39   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../var/ Snapshot Created...
2012-08-03 08:42:39   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:42:39   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Completed Creating Snapshots...
2012-08-03 08:42:39   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:42:39   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Creating Memory Disk Devices...
2012-08-03 08:42:39   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:42:39   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Creating /dev/md0 from Snapshot for /...
2012-08-03 08:42:49   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../dev/md0 Created from Snapshot for /...
2012-08-03 08:42:49   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:42:49   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Creating /dev/md1 from Snapshot for /usr/...
2012-08-03 08:43:00   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../dev/md1 Created from Snapshot for /usr/...
2012-08-03 08:43:00   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:43:00   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Creating /dev/md2 from Snapshot for /var/...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../dev/md2 Created from Snapshot for /var/...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Completed Creating Memory Disk Devices...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Mount Memory Disk Devices...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Mounting /dev/md0 as /...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../dev/md0 Mounted as /...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Mounting /dev/md1 as /usr/...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../dev/md1 Mounted as /usr/...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: ...Mounting /dev/md2 as /var/...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: .../dev/md2 Mounted as /var/...
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob:
2012-08-03 08:43:10   webmail.dweimer.local-fd JobId 730: 
ClientRunBeforeJob: Completed Mounting Memory Disk Devices...
2012-08-03 08:43:10   File JobId 730: Volume "BV12" previously written, 
moving to end of data.
2012-08-03 08:43:10   File JobId 730: Ready to append to end of Volume 
"BV12" size=86987279229
2012-08-03 08:52:59   File JobId 730: Job write elapsed time = 
00:09:49, Transfer rate = 8.900 M Bytes/second
2012-08-03 08:52:59   webmail.dweimer.local-fd JobId 730: shell 
command: run ClientAfterJob "/root/bacula/after.sh"
2012-08-03 08:52:59   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:52:59   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: Unmount Memory Disk Devices...
2012-08-03 08:52:59   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:52:59   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Unmounting /dev/md2...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../dev/md2...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Unmounting /dev/md1...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../dev/md1...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Unmounting /dev/md0...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../dev/md0...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: Completed Unmounting Memory Disk Devices...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: Deleting Memory Disk Devices...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Deleting /dev/md2...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../dev/md2 Deleted...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Deleting /dev/md1...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../dev/md1 Deleted...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Deleting /dev/md0...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../dev/md0 Deleted...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: Completed Deleting Memory Disk Devices...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: Deleting Snapshots...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Deleting Snapshot /...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../ Snapshot Deleted...
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:00   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Deleting Snapshot /usr/...
2012-08-03 08:53:27   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../usr/ Snapshot Deleted...
2012-08-03 08:53:27   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:27   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: ...Deleting Snapshot /var/...
2012-08-03 08:53:31   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: .../var/ Snapshot Deleted...
2012-08-03 08:53:31   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob:
2012-08-03 08:53:31   webmail.dweimer.local-fd JobId 730: 
ClientAfterJob: Completed Deleting Snapshots...
2012-08-03 08:54:05   webmail.dweimer.local-dir JobId 730: Bacula 
webmail.dweimer.local-dir 5.2.10 (28Jun12):
   Build OS:               amd64-portbld-freebsd9.0 freebsd 
9.0-RELEASE-p3
   JobId:                  730
   Job:                    webmail-Backup.2012-08-03_08.31.53_26
   Backup Level:           Incremental, since=2012-08-02 23:38:17
   Client:                 "webmail.dweimer.local-fd" 5.2.10 (28Jun12) 
amd64-portbld-freebsd9.0,freebsd,9.0-RELEASE-p3
   FileSet:                "Snapshot" 2012-02-20 17:39:41
   Pool:                   "File" (From Job resource)
   Catalog:                "MyCatalog" (From Client resource)
   Storage:                "File" (From Job resource)
   Scheduled time:         03-Aug-2012 08:31:51
   Start time:             03-Aug-2012 08:43:10
   End time:               03-Aug-2012 08:54:05
   Elapsed time:           10 mins 55 secs
   Priority:               10
   FD Files Written:       53,106
   SD Files Written:       53,106
   FD Bytes Written:       5,232,934,578 (5.232 GB)
   SD Bytes Written:       5,242,498,493 (5.242 GB)
   Rate:                   7989.2 KB/s
   Software Compression:   None
   VSS:                    no
   Encryption:             no
   Accurate:               no
   Volume name(s):         BV12
   Volume Session Id:      7
   Volume Session Time:    1343926830
   Last Volume Bytes:      92,235,221,416 (92.23 GB)
   Non-fatal FD errors:    0
   SD Errors:              0
   FD termination status:  OK
   SD termination status:  OK
   Termination:            Backup OK
2012-08-03 08:54:05   webmail.dweimer.local-dir JobId 730: Begin 
pruning Jobs older than 20 days .
2012-08-03 08:54:05   webmail.dweimer.local-dir JobId 730: Pruned 1 Job 
for client webmail.dweimer.local-fd from catalog.
2012-08-03 08:54:05   webmail.dweimer.local-dir JobId 730: Begin 
pruning Files.
2012-08-03 08:54:05   webmail.dweimer.local-dir JobId 730: No Files 
found to prune.
2012-08-03 08:54:05   webmail.dweimer.local-dir JobId 730: End auto 
prune.

Client 2 Log:
2012-08-03 08:54:07   webmail.dweimer.local-dir JobId 731: Start Backup 
JobId 731, Job=FreeNAS-Backup.2012-08-03_08.32.04_27
2012-08-03 08:54:07   webmail.dweimer.local-dir JobId 731: Using Device 
"FileStorage"
2012-08-03 08:54:08   freenasp.dweimer.local-fd JobId 731: shell 
command: run ClientRunBeforeJob 
"/mnt/FreeNAS/V01/system/root/bacula/before.sh"
2012-08-03 08:54:08   File JobId 731: Volume "BV12" previously written, 
moving to end of data.
2012-08-03 08:54:08   File JobId 731: Ready to append to end of Volume 
"BV12" size=92235221416
2012-08-03 08:54:31   File JobId 731: Job write elapsed time = 
00:00:23, Transfer rate = 170.1 K Bytes/second
2012-08-03 08:54:31   webmail.dweimer.local-dir JobId 731: Bacula 
webmail.dweimer.local-dir 5.2.10 (28Jun12):
   Build OS:               amd64-portbld-freebsd9.0 freebsd 
9.0-RELEASE-p3
   JobId:                  731
   Job:                    FreeNAS-Backup.2012-08-03_08.32.04_27
   Backup Level:           Incremental, since=2012-08-02 23:47:08
   Client:                 "freenasp.dweimer.local-fd" 5.2.10 (28Jun12) 
amd64-portbld-freebsd8.2,freebsd,8.2-RELEASE-p9
   FileSet:                "FreeNAS" 2012-02-20 17:39:21
   Pool:                   "File" (From Job resource)
   Catalog:                "MyCatalog" (From Client resource)
   Storage:                "File" (From Job resource)
   Scheduled time:         03-Aug-2012 08:32:00
   Start time:             03-Aug-2012 08:54:08
   End time:               03-Aug-2012 08:54:31
   Elapsed time:           23 secs
   Priority:               10
   FD Files Written:       28
   SD Files Written:       28
   FD Bytes Written:       3,909,851 (3.909 MB)
   SD Bytes Written:       3,913,193 (3.913 MB)
   Rate:                   170.0 KB/s
   Software Compression:   None
   VSS:                    no
   Encryption:             no
   Accurate:               no
   Volume name(s):         BV12
   Volume Session Id:      8
   Volume Session Time:    1343926830
   Last Volume Bytes:      92,239,138,715 (92.23 GB)
   Non-fatal FD errors:    0
   SD Errors:              0
   FD termination status:  OK
   SD termination status:  OK
   Termination:            Backup OK
2012-08-03 08:54:32   webmail.dweimer.local-dir JobId 731: Begin 
pruning Jobs older than 20 days .
2012-08-03 08:54:32   webmail.dweimer.local-dir JobId 731: No Jobs 
found to prune.
2012-08-03 08:54:32   webmail.dweimer.local-dir JobId 731: Begin 
pruning Files.
2012-08-03 08:54:32   webmail.dweimer.local-dir JobId 731: No Files 
found to prune.
2012-08-03 08:54:32   webmail.dweimer.local-dir JobId 731: End auto 
prune.

Unfortunately I missed the storage status while the jobs were actively 
writing to volumes as I got interupted to work on another issue.  I can 
run them again and try to grab that if you don't see anythign here.

-- 
Thanks,
    Dean E. Weimer
    http://www.dweimer.net/

------------------------------------------------------------------------------
Live Security Virtual Conference
Exclusive live event will cover all the ways today's security and 
threat landscape has changed and how IT managers can respond. Discussions 
will include endpoint security, mobile security and the latest in malware 
threats. http://www.accelacomm.com/jaw/sfrnl04242012/114/50122263/
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users