Last week I updated my bacula server from Ubuntu 10.04 to 12.04. During this
update Bacula was also updated from 5.0.3 to 5.2.5. Since then the backups of
my Windows 2003 servers take much longer than before.
One example:
With Bacula 5.0.3:
02-Okt 18:45 Bandsicherung-dir JobId 2574: Start Sicherung JobId 2574,
Job=SERVER1.2012-10-02_18.45.00_48
02-Okt 18:45 Bandsicherung-dir JobId 2574: Max configured use duration=82,800
sec. exceeded. Marking Volume "MON-G" as Used.
02-Okt 18:47 Bandsicherung-dir JobId 2574: There are no more Jobs associated
with Volume "DIE-G". Marking it purged.
02-Okt 18:47 Bandsicherung-dir JobId 2574: All records pruned from Volume
"DIE-G"; marking it "Purged"
02-Okt 18:47 Bandsicherung-dir JobId 2574: Recycled volume "DIE-G"
02-Okt 18:47 Bandsicherung-dir JobId 2574: Using Device "LTO-3"
02-Okt 18:47 Bandsicherung-sd JobId 2574: Recycled volume "DIE-G" on device
"LTO-3" (/dev/nst0), all previous data lost.
02-Okt 18:47 Bandsicherung-sd JobId 2574: Spooling data ...
02-Okt 18:47 server1-fd JobId 2574: Generate VSS snapshots. Driver="VSS Win
2003", Drive(s)="ED"
03-Okt 01:21 Bandsicherung-sd JobId 2574: Job write elapsed time = 06:33:59,
Transfer rate = 5.685 M Bytes/second
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "System
Writer", State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 Bandsicherung-sd JobId 2574: Committing spooled data to Volume
"DIE-G". Despooling 134,556,017,213 bytes ...
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "FRS Writer",
State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete):
"SqlServerWriter", State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "IIS Metabase
Writer", State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "Event Log
Writer", State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "COM+ REGDB
Writer", State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "MSDEWriter",
State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "Registry
Writer", State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "WMI Writer",
State: 0x1 (VSS_WS_STABLE)
03-Okt 01:21 server1-fd JobId 2574: VSS Writer (BackupComplete): "NTDS", State:
0x1 (VSS_WS_STABLE)
03-Okt 02:07 Bandsicherung-sd JobId 2574: Despooling elapsed time = 00:45:52,
Transfer rate = 48.89 M Bytes/second
03-Okt 02:09 Bandsicherung-sd JobId 2574: Sending spooled attrs to the
Director. Despooling 231,103,197 bytes ...
03-Okt 02:12 Bandsicherung-dir JobId 2574: Bacula Bandsicherung-dir 5.0.3
(04Aug10): 03-Okt-2012 02:12:29
Build OS: x86_64-pc-linux-gnu ubuntu 11.04
JobId: 2574
Job: SERVER1.2012-10-02_18.45.00_48
Backup Level: Full
Client: "server1-fd" 5.0.3 (04Aug10) Linux,Cross-compile,Win32
FileSet: "SERVER1-FileSet" 2012-06-22 18:45:00
Pool: "GeradeWoche" (From Run pool override)
Catalog: "MyCatalog" (From Client resource)
Storage: "LTO-3" (From Job Ressource)
Scheduled time: 02-Okt-2012 18:45:00
Start time: 02-Okt-2012 18:47:01
End time: 03-Okt-2012 02:12:29
Elapsed time: 7 hours 25 mins 28 secs
Priority: 10
FD Files Written: 688,756
SD Files Written: 688,756
FD Bytes Written: 134,285,655,838 (134.2 GB)
SD Bytes Written: 134,408,090,407 (134.4 GB)
Rate: 5024.2 KB/s
Software Compression: None
VSS: yes
Encryption: no
Accurate: no
Volume name(s): DIE-G
Volume Session Id: 51
Volume Session Time: 1348229559
Last Volume Bytes: 134,531,066,880 (134.5 GB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Sicherung OK
With Bacula 5.2.5:
29-Okt 18:00 Bandsicherung-dir JobId 2710: Start Sicherung JobId 2710,
Job=SERVER1.2012-10-29_18.00.00_03
29-Okt 18:00 Bandsicherung-dir JobId 2710: Gerät »LTO-3« wird verwendet
29-Okt 18:00 Bandsicherung-sd JobId 2710: Wrote label to prelabeled Volume
"MON-G" on device "LTO-3" (/dev/nst0)
29-Okt 18:00 Bandsicherung-sd JobId 2710: Spooling data ...
29-Okt 18:00 server1-fd JobId 2710: Generate VSS snapshots. Driver="Win32 VSS",
Drive(s)="ED"
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "System
Writer", State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete):
"SqlServerWriter", State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "FRS Writer",
State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "Registry
Writer", State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "MSDEWriter",
State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "Event Log
Writer", State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "NTDS", State:
0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "IIS Metabase
Writer", State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "WMI Writer",
State: 0x1 (VSS_WS_STABLE)
30-Okt 00:45 server1-fd JobId 2710: VSS Writer (BackupComplete): "COM+ REGDB
Writer", State: 0x1 (VSS_WS_STABLE)
30-Okt 00:46 Bandsicherung-sd JobId 2710: Job write elapsed time = 06:45:53,
Transfer rate = 5.624 M Bytes/second
30-Okt 00:46 Bandsicherung-sd JobId 2710: Committing spooled data to Volume
"MON-G". Despooling 137,133,814,776 bytes ...
30-Okt 01:31 Bandsicherung-sd JobId 2710: Despooling elapsed time = 00:45:28,
Transfer rate = 50.26 M Bytes/second
30-Okt 01:31 Bandsicherung-sd JobId 2710: Sending spooled attrs to the
Director. Despooling 237,257,153 bytes ...
30-Okt 09:14 Bandsicherung-dir JobId 2710: Bacula Bandsicherung-dir 5.2.5
(26Jan12):
Build OS: x86_64-pc-linux-gnu ubuntu 12.04
JobId: 2710
Job: SERVER1.2012-10-29_18.00.00_03
Backup Level: Full
Client: "server1-fd" 5.2.10 (28Jun12) Microsoft Windows Home
ServerStandard Edition Service Pack 2 (build 3790),Cross-compile,Win32
FileSet: "SERVER1-FileSet" 2012-06-22 18:45:00
Pool: "GeradeWoche" (From Run pool override)
Catalog: "MyCatalog" (From Client resource)
Storage: "LTO-3" (From Job Ressource)
Scheduled time: 29-Okt-2012 18:00:00
Start time: 29-Okt-2012 18:00:02
End time: 30-Okt-2012 09:14:53
Elapsed time: 15 hours 14 mins 51 secs
Priority: 10
FD Files Written: 703,150
SD Files Written: 703,150
FD Bytes Written: 136,856,722,794 (136.8 GB)
SD Bytes Written: 136,983,010,514 (136.9 GB)
Rate: 2493.2 KB/s
Software Compression: None
VSS: Ja
Encryption: Nein
Accurate: Nein
Volume name(s): MON-G
Volume Session Id: 8
Volume Session Time: 1351269798
Last Volume Bytes: 137,108,385,792 (137.1 GB)
Non-fatal FD errors: 0
SD Errors: 0
FD termination status: OK
SD termination status: OK
Termination: Sicherung OK
It seems that "Sending spooled attrs to the Director" takes much longer than
before. Can you give me some aid in solving this problem?
Carsten
------------------------------------------------------------------------------
Everyone hates slow websites. So do we.
Make your web apps faster with AppDynamics
Download AppDynamics Lite for free today:
http://p.sf.net/sfu/appdyn_sfd2d_oct
_______________________________________________
Bacula-users mailing list
Bacula-users AT lists.sourceforge DOT net
https://lists.sourceforge.net/lists/listinfo/bacula-users
|