27-Oct 23:05 uklxhome0-dir JobId 552: Start Backup JobId 552, Job=uklxfs1_surge2_job.2009-10-27_23.05.00_12 27-Oct 23:07 uklxhome0-dir JobId 552: Using Device "Drive-3" 27-Oct 23:08 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:09 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:12 uklxhome0-sd JobId 552: Warning: Volume "LX0019" is in use by device "Drive-2" (/dev/tape/by-id/scsi-3500308c09f221098-nst) 27-Oct 23:12 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:12 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:12 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:12 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:12 uklxhome0-sd JobId 552: Warning: mount.c:219 Open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst) Volume "LX0019" failed: ERR=dev.c:474 Unable to open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst): ERR=No medium found 27-Oct 23:12 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:13 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:16 uklxhome0-sd JobId 552: Warning: Volume "LX0019" is in use by device "Drive-2" (/dev/tape/by-id/scsi-3500308c09f221098-nst) 27-Oct 23:16 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:16 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:16 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:16 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:16 uklxhome0-sd JobId 552: Warning: mount.c:219 Open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst) Volume "LX0019" failed: ERR=dev.c:474 Unable to open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst): ERR=No medium found 27-Oct 23:16 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:17 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:20 uklxhome0-sd JobId 552: Warning: Volume "LX0019" is in use by device "Drive-2" (/dev/tape/by-id/scsi-3500308c09f221098-nst) 27-Oct 23:20 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:20 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:20 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:20 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:20 uklxhome0-sd JobId 552: Warning: mount.c:219 Open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst) Volume "LX0019" failed: ERR=dev.c:474 Unable to open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst): ERR=No medium found 27-Oct 23:20 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:20 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:23 uklxhome0-sd JobId 552: Warning: Volume "LX0019" is in use by device "Drive-2" (/dev/tape/by-id/scsi-3500308c09f221098-nst) 27-Oct 23:23 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:24 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:24 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:24 uklxhome0-sd JobId 552: 3302 Autochanger "loaded? drive 3", result: nothing loaded. 27-Oct 23:24 uklxhome0-sd JobId 552: Warning: mount.c:219 Open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst) Volume "LX0019" failed: ERR=dev.c:474 Unable to open device "Drive-3" (/dev/tape/by-id/scsi-3500308c09f22109c-nst): ERR=No medium found 27-Oct 23:24 uklxhome0-sd JobId 552: 3301 Issuing autochanger "loaded? drive 3" command. 27-Oct 23:27-Oct 23:05 uklxhome0-dir JobId 554: Start Backup JobId 554, Job=uklxfs2_m12_job.2009-10-27_23.05.00_14 27-Oct 23:34 uklxhome0-dir JobId 554: Using Device "Drive-2" 27-Oct 23:34 uklxhome0-sd JobId 554: Job write elapsed time = 00:00:01, Transfer rate = 0 bytes/second 27-Oct 23:34 uklxhome0-dir JobId 554: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:34:38 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 554 Job: uklxfs2_m12_job.2009-10-27_23.05.00_14 Backup Level: Incremental, since=2009-10-26 23:06:20 Client: "uklxfs2-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxfs2_m12_set" 2009-10-02 10:03:35 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:34:33 End time: 27-Oct-2009 23:34:38 Elapsed time: 5 secs Priority: 10 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): LX0018 Volume Session Id: 6 Volume Session Time: 1256658721 Last Volume Bytes: 1,118,571,579,392 (1.118 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:34 uklxhome0-dir JobId 554: Begin pruning Jobs. 27-Oct 23:34 uklxhome0-dir JobId 554: No Jobs found to prune. 27-Oct 23:34 uklxhome0-dir JobId 554: Begin pruning Files. 27-Oct 23:34 uklxhome0-dir JobId 554: No Files found to prune. 27-Oct 23:34 uklxhome0-dir JobId 554: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 553: Start Backup JobId 553, Job=uklxfs2_m8_job.2009-10-27_23.05.00_13 27-Oct 23:34 uklxhome0-dir JobId 553: Using Device "Drive-2" 27-Oct 23:34 uklxhome0-sd JobId 553: Job write elapsed time = 00:00:16, Transfer rate = 0 bytes/second 27-Oct 23:34 uklxhome0-dir JobId 553: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:34:49 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 553 Job: uklxfs2_m8_job.2009-10-27_23.05.00_13 Backup Level: Incremental, since=2009-10-26 23:06:20 Client: "uklxfs2-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxfs2_m8_set" 2009-10-02 10:17:22 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:34:33 End time: 27-Oct-2009 23:34:49 Elapsed time: 16 secs Priority: 10 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: 8 Volume Session Time: 1256658721 Last Volume Bytes: 1,118,571,580,416 (1.118 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:34 uklxhome0-dir JobId 553: Begin pruning Jobs. 27-Oct 23:34 uklxhome0-dir JobId 553: No Jobs found to prune. 27-Oct 23:34 uklxhome0-dir JobId 553: Begin pruning Files. 27-Oct 23:34 uklxhome0-dir JobId 553: No Files found to prune. 27-Oct 23:34 uklxhome0-dir JobId 553: End auto prune. 27-Oct 23:34 uklxhome0-dir JobId 560: Start Backup JobId 560, Job=uklxmodel3_data_job.2009-10-27_23.05.00_20 27-Oct 23:34 uklxhome0-dir JobId 560: Using Device "Drive-4" 27-Oct 23:34 uklxhome0-sd JobId 560: Job write elapsed time = 00:00:09, Transfer rate = 0 bytes/second 27-Oct 23:34 uklxhome0-dir JobId 560: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:34:55 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 560 Job: uklxmodel3_data_job.2009-10-27_23.05.00_20 Backup Level: Incremental, since=2009-10-26 23:09:42 Client: "uklxmodel3-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxmodel3_data_set" 2009-10-02 12:28:42 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:34:42 End time: 27-Oct-2009 23:34:55 Elapsed time: 13 secs Priority: 10 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): LX0021 Volume Session Id: 15 Volume Session Time: 1256658721 Last Volume Bytes: 3,282,923,520 (3.282 GB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:34 uklxhome0-dir JobId 560: Begin pruning Jobs. 27-Oct 23:34 uklxhome0-dir JobId 560: No Jobs found to prune. 27-Oct 23:34 uklxhome0-dir JobId 560: Begin pruning Files. 27-Oct 23:34 uklxhome0-dir JobId 560: No Files found to prune. 27-Oct 23:34 uklxhome0-dir JobId 560: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 548: Start Backup JobId 548, Job=BackupClient1.2009-10-27_23.05.00_08 27-Oct 23:05 uklxhome0-dir JobId 548: Using Device "Drive-0" 27-Oct 23:05 uklxhome0-sd JobId 548: 3307 Issuing autochanger "unload slot 81, drive 0" command. 27-Oct 23:05 uklxhome0-sd JobId 548: 3304 Issuing autochanger "load slot 12, drive 0" command. 27-Oct 23:06 uklxhome0-sd JobId 548: 3305 Autochanger "load slot 12, drive 0", status is OK. 27-Oct 23:06 uklxhome0-sd JobId 548: Volume "LX0020" previously written, moving to end of data. 27-Oct 23:07 uklxhome0-sd JobId 548: Ready to append to end of Volume "LX0020" at file=413. 27-Oct 23:08 uklxhome0-sd JobId 548: Job write elapsed time = 00:00:41, Transfer rate = 1.607 K bytes/second 27-Oct 23:34 uklxhome0-dir JobId 548: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:34:57 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 548 Job: BackupClient1.2009-10-27_23.05.00_08 Backup Level: Incremental, since=2009-10-26 23:05:02 Client: "uklxhome0-fd" 3.0.3 (18Oct09) x86_64-suse-linux-gnu,suse,10 FileSet: "Full Set" 2009-09-30 13:49:56 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:05:00 End time: 27-Oct-2009 23:34:57 Elapsed time: 29 mins 57 secs Priority: 10 FD Files Written: 8 SD Files Written: 8 FD Bytes Written: 65,176 (65.17 KB) SD Bytes Written: 65,918 (65.91 KB) Rate: 0.0 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0020 Volume Session Id: 4 Volume Session Time: 1256658721 Last Volume Bytes: 407,604,481,024 (407.6 GB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:34 uklxhome0-dir JobId 548: Begin pruning Jobs. 27-Oct 23:34 uklxhome0-dir JobId 548: No Jobs found to prune. 27-Oct 23:34 uklxhome0-dir JobId 548: Begin pruning Files. 27-Oct 23:34 uklxhome0-dir JobId 548: No Files found to prune. 27-Oct 23:34 uklxhome0-dir JobId 548: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 551: Start Backup JobId 551, Job=uklxfs1_opt_job.2009-10-27_23.05.00_11 27-Oct 23:07 uklxhome0-dir JobId 551: Max configured use duration exceeded. Marking Volume "LX0008" as Used. 27-Oct 23:07 uklxhome0-dir JobId 551: Using Device "Drive-4" 27-Oct 23:31 uklxhome0-sd JobId 551: 3301 Issuing autochanger "loaded? drive 4" command. 27-Oct 23:32 uklxhome0-sd JobId 551: 3302 Autochanger "loaded? drive 4", result: nothing loaded. 27-Oct 23:32 uklxhome0-sd JobId 551: 3304 Issuing autochanger "load slot 13, drive 4" command. 27-Oct 23:33 uklxhome0-sd JobId 551: 3305 Autochanger "load slot 13, drive 4", status is OK. 27-Oct 23:33 uklxhome0-sd JobId 551: Error: block.c:1010 Read error on fd=28 at file:blk 0:0 on device "Drive-4" (/dev/tape/by-id/scsi-3500308c09f221000-nst). ERR=Input/output error. 27-Oct 23:33 uklxhome0-sd JobId 551: Labeled new Volume "LX0021" on device "Drive-4" (/dev/tape/by-id/scsi-3500308c09f221000-nst). 27-Oct 23:33 uklxhome0-sd JobId 551: Wrote label to prelabeled Volume "LX0021" on device "Drive-4" (/dev/tape/by-id/scsi-3500308c09f221000-nst) 27-Oct 23:34 uklxhome0-sd JobId 551: Job write elapsed time = 00:01:20, Transfer rate = 41.02 M bytes/second 27-Oct 23:34 uklxhome0-dir JobId 551: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:34:57 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 551 Job: uklxfs1_opt_job.2009-10-27_23.05.00_11 Backup Level: Incremental, since=2009-10-26 23:06:20 Client: "uklxfs1-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxfs1_opt_set" 2009-10-02 11:51:53 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:07:54 End time: 27-Oct-2009 23:34:57 Elapsed time: 27 mins 3 secs Priority: 10 FD Files Written: 10 SD Files Written: 10 FD Bytes Written: 3,282,205,646 (3.282 GB) SD Bytes Written: 3,282,206,865 (3.282 GB) Rate: 2022.3 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0021 Volume Session Id: 9 Volume Session Time: 1256658721 Last Volume Bytes: 3,282,923,520 (3.282 GB) Non-fatal FD errors: 0 SD Errors: 1 FD termination status: OK SD termination status: OK Termination: Backup OK -- with warnings 27-Oct 23:34 uklxhome0-dir JobId 551: Begin pruning Jobs. 27-Oct 23:34 uklxhome0-dir JobId 551: No Jobs found to prune. 27-Oct 23:35 uklxhome0-dir JobId 551: Begin pruning Files. 27-Oct 23:35 uklxhome0-dir JobId 551: No Files found to prune. 27-Oct 23:35 uklxhome0-dir JobId 551: End auto prune. 27-Oct 23:34 uklxhome0-dir JobId 561: Start Backup JobId 561, Job=uklxmodel3-db.2009-10-27_23.05.00_21 27-Oct 23:34 uklxhome0-dir JobId 561: Using Device "Drive-4" 27-Oct 23:34 uklxmodel3-fd JobId 561: shell command: run ClientRunBeforeJob "/etc/bacula/postgres_pre.sh" 27-Oct 23:34 uklxmodel3-fd JobId 561: ClientRunBeforeJob: /etc/bacula/postgres_pre.sh: line 9: pg_dumpall: command not found 27-Oct 23:34 uklxmodel3-fd JobId 561: ClientRunBeforeJob: /etc/bacula/postgres_pre.sh: line 20: psql: command not found 27-Oct 23:35 uklxhome0-sd JobId 561: Spooling data ... 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_Cathedral_Capital.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxhome0-sd JobId 561: Job write elapsed time = 00:00:01, Transfer rate = 112 bytes/second 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_Cathedral_Capital.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxhome0-sd JobId 561: Committing spooled data to Volume "LX0021". Despooling 576 bytes ... 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_Citizens_HRA_051231withsqft.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_Citizens_HRA_051231withsqft.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxhome0-sd JobId 561: Despooling elapsed time = 00:00:02, Transfer rate = 288 bytes/second 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_filling2.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_filling2.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_filling_uniform_exp.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/EDM_filling_uniform_exp.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/IED2007_EUWS_PC_EURO_EDM70.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/IED2007_EUWS_PC_EURO_EDM70.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_EDM_MX_ECO_ADMIN2_R10a.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_EDM_MX_ECO_ADMIN2_R10a.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_EDM_MX_INS_ADMIN2_R10a.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_EDM_MX_INS_ADMIN2_R10a.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_vulnerability.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_vulnerability.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_vulnerability_HU_8.0.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/RMS_vulnerability_HU_8.0.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2006_USHU_ZIP_EDM60.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2006_USHU_ZIP_EDM60.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_cbws_ct_usd_edm80.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_cbws_ct_usd_edm80.data.dump": ERR27-Oct 23:35 uklxhome0-dir JobId 562: Start Backup JobId 562, Job=uklxmodel4_data_job.2009-10-27_23.05.00_22 27-Oct 23:35 uklxhome0-dir JobId 562: Using Device "Drive-2" 27-Oct 23:35 uklxhome0-sd JobId 562: Job write elapsed time = 00:00:01, Transfer rate = 0 bytes/second 27-Oct 23:35 uklxhome0-dir JobId 562: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:35:04 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 562 Job: uklxmodel4_data_job.2009-10-27_23.05.00_22 Backup Level: Incremental, since=2009-10-26 23:09:42 Client: "uklxmodel4-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxmodel4_data_set" 2009-10-13 11:09:56 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:35:03 End time: 27-Oct-2009 23:35:04 Elapsed time: 1 sec Priority: 10 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: 17 Volume Session Time: 1256658721 Last Volume Bytes: 1,118,571,581,440 (1.118 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:35 uklxhome0-dir JobId 562: Begin pruning Jobs. 27-Oct 23:35 uklxhome0-dir JobId 562: No Jobs found to prune. 27-Oct 23:35 uklxhome0-dir JobId 562: Begin pruning Files. 27-Oct 23:35 uklxhome0-dir JobId 562: No Files found to prune. 27-Oct 23:35 uklxhome0-dir JobId 562: End auto prune. =No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_ushu_pc_usd_edm80.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_ushu_pc_usd_edm80.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_ushu_pc_usd_edm80_MIAMI.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_ushu_pc_usd_edm80_MIAMI.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_usop_edm80.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008_usop_edm80.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008cashu_pc_cad_edm80.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ied2008cashu_pc_cad_edm80.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ish.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/ish.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/postgres.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/postgres.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/rl_hazard_lookup.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/rl_hazard_lookup.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/template1.schema.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: Could not stat "/tmp/pgsql/dump/fifo/template1.data.dump": ERR=No such file or directory 27-Oct 23:35 uklxmodel3-fd JobId 561: shell command: run ClientAfterJob "/etc/bacula/postgres_post.sh" 27-Oct 23:35 uklxmodel3-fd JobId 561: ClientAfterJob: /etc/bacula/postgres_post.sh: line 14: psql: command not found 27-Oct 23:35 uklxhome0-sd JobId 561: Sending spooled attrs to the Director. Despooling 286 bytes ... 27-Oct 23:35 uklxhome0-dir JobId 561: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:35:07 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 561 Job: uklxmodel3-db.2009-10-27_23.05.00_21 Backup Level: Full Client: "uklxmodel3-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxmodel3-db-set" 2009-10-13 23:10:00 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:35:01 End time: 27-Oct-2009 23:35:07 Elapsed time: 6 secs Priority: 10 FD Files Written: 1 SD Files Written: 1 FD Bytes Written: 0 (0 B) SD Bytes Written: 112 (112 B) Rate: 0.0 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0021 Volume Session Id: 16 Volume Session Time: 1256658721 Last Volume Bytes: 3,282,924,544 (3.282 GB) Non-fatal FD errors: 38 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK -- with warnings 27-Oct 23:35 uklxhome0-dir JobId 561: Begin pruning Jobs. 27-Oct 23:35 uklxhome0-dir JobId 561: No Jobs found to prune. 27-Oct 23:35 uklxhome0-dir JobId 561: Begin pruning Files. 27-Oct 23:35 uklxhome0-dir JobId 561: No Files found to prune. 27-Oct 23:35 uklxhome0-dir JobId 561: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 558: Start Backup JobId 558, Job=uklxmodel1_flood-uklxfs1-job.2009-10-27_23.05.00_18 27-Oct 23:34 uklxhome0-dir JobId 558: Using Device "Drive-0" 27-Oct 23:35 uklxhome0-sd JobId 558: Job write elapsed time = 00:00:39, Transfer rate = 0 bytes/second 27-Oct 23:35 uklxhome0-dir JobId 558: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:35:12 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 558 Job: uklxmodel1_flood-uklxfs1-job.2009-10-27_23.05.00_18 Backup Level: Incremental, since=2009-10-27 12:02:33 Client: "uklxmodel1-fd" 2.2.8 (26Jan08) x86_64-pc-linux-gnu,debian,lenny/sid FileSet: "uklxmodel1_flood-uklxfs1-set" 2009-10-07 11:44:09 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:34:33 End time: 27-Oct-2009 23:35:12 Elapsed time: 39 secs Priority: 10 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: 13 Volume Session Time: 1256658721 Last Volume Bytes: 408,425,517,056 (408.4 GB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:35 uklxhome0-dir JobId 558: Begin pruning Jobs. 27-Oct 23:35 uklxhome0-dir JobId 558: No Jobs found to prune. 27-Oct 23:35 uklxhome0-dir JobId 558: Begin pruning Files. 27-Oct 23:35 uklxhome0-dir JobId 558: No Files found to prune. 27-Oct 23:35 uklxhome0-dir JobId 558: End auto prune. 27-Oct 23:35 uklxhome0-dir JobId 565: Start Backup JobId 565, Job=uklxmodel11_wind_job.2009-10-27_23.05.00_25 27-Oct 23:35 uklxhome0-dir JobId 565: Using Device "Drive-2" 27-Oct 23:35 uklxhome0-sd JobId 565: Job write elapsed time = 00:00:04, Transfer rate = 27 bytes/second 27-Oct 23:35 uklxhome0-dir JobId 565: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:35:13 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 565 Job: uklxmodel11_wind_job.2009-10-27_23.05.00_25 Backup Level: Incremental, since=2009-10-26 23:09:59 Client: "uklxmodel11-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxmodel11_wind_set" 2009-10-01 15:59:57 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:35:08 End time: 27-Oct-2009 23:35:13 Elapsed time: 5 secs Priority: 10 FD Files Written: 1 SD Files Written: 1 FD Bytes Written: 0 (0 B) SD Bytes Written: 108 (108 B) Rate: 0.0 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0018 Volume Session Id: 20 Volume Session Time: 1256658721 Last Volume Bytes: 1,118,571,582,464 (1.118 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:35 uklxhome0-dir JobId 565: Begin pruning Jobs. 27-Oct 23:35 uklxhome0-dir JobId 565: No Jobs found to prune. 27-Oct 23:35 uklxhome0-dir JobId 565: Begin pruning Files. 27-Oct 23:35 uklxhome0-dir JobId 565: No Files found to prune. 27-Oct 23:35 uklxhome0-dir JobId 565: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 555: Start Backup JobId 555, Job=uklxmodel1_flood_job.2009-10-27_23.05.00_15 27-Oct 23:07 uklxhome0-dir JobId 555: Using Device "Drive-5" 27-Oct 23:33 uklxhome0-sd JobId 555: 3301 Issuing autochanger "loaded? drive 5" command. 27-Oct 23:33 uklxhome0-sd JobId 555: 3302 Autochanger "loaded? drive 5", result: nothing loaded. 27-Oct 23:33 uklxhome0-sd JobId 555: 3304 Issuing autochanger "load slot 14, drive 5" command. 27-Oct 23:34 uklxhome0-sd JobId 555: 3305 Autochanger "load slot 14, drive 5", status is OK. 27-Oct 23:34 uklxhome0-sd JobId 555: Error: block.c:1010 Read error on fd=30 at file:blk 0:0 on device "Drive-5" (/dev/tape/by-id/scsi-3500308c09f221004-nst). ERR=Input/output error. 27-Oct 23:34 uklxhome0-sd JobId 555: Labeled new Volume "LX0022" on device "Drive-5" (/dev/tape/by-id/scsi-3500308c09f221004-nst). 27-Oct 23:34 uklxhome0-sd JobId 555: Wrote label to prelabeled Volume "LX0022" on device "Drive-5" (/dev/tape/by-id/scsi-3500308c09f221004-nst) 27-Oct 23:35 uklxhome0-sd JobId 555: Job write elapsed time = 00:01:10, Transfer rate = 0 bytes/second 27-Oct 23:35 uklxhome0-dir JobId 555: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:35:45 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 555 Job: uklxmodel1_flood_job.2009-10-27_23.05.00_15 Backup Level: Incremental, since=2009-10-27 11:50:39 Client: "uklxmodel1-fd" 2.2.8 (26Jan08) x86_64-pc-linux-gnu,debian,lenny/sid FileSet: "uklxmodel1_flood_set" 2009-10-07 11:43:53 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:07:54 End time: 27-Oct-2009 23:35:45 Elapsed time: 27 mins 51 secs Priority: 10 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: 10 Volume Session Time: 1256658721 Last Volume Bytes: 2,048 (2.048 KB) Non-fatal FD errors: 0 SD Errors: 1 FD termination status: OK SD termination status: OK Termination: Backup OK -- with warnings 27-Oct 23:35 uklxhome0-dir JobId 555: Begin pruning Jobs. 27-Oct 23:35 uklxhome0-dir JobId 555: No Jobs found to prune. 27-Oct 23:35 uklxhome0-dir JobId 555: Begin pruning Files. 27-Oct 23:35 uklxhome0-dir JobId 555: No Files found to prune. 27-Oct 23:35 uklxhome0-dir JobId 555: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 550: Start Backup JobId 550, Job=uklxblade0-db.2009-10-27_23.05.00_10 27-Oct 23:07 uklxhome0-dir JobId 550: Using Device "Drive-2" 27-Oct 23:07 uklxblade0-fd JobId 550: shell command: run ClientRunBeforeJob "/etc/bacula/postgres_pre.sh" 27-Oct 23:28 uklxhome0-sd JobId 550: Warning: mount.c:441 Could not reserve volume LX0019 on "Drive-2" (/dev/tape/by-id/scsi-3500308c09f221098-nst) 27-Oct 23:28 uklxhome0-sd JobId 550: 3307 Issuing autochanger "unload slot 11, drive 2" command. 27-Oct 23:29 uklxhome0-sd JobId 550: 3301 Issuing autochanger "loaded? drive 2" command. 27-Oct 23:29 uklxhome0-sd JobId 550: 3302 Autochanger "loaded? drive 2", result: nothing loaded. 27-Oct 23:29 uklxhome0-sd JobId 550: 3304 Issuing autochanger "load slot 10, drive 2" command. 27-Oct 23:30 uklxhome0-sd JobId 550: 3305 Autochanger "load slot 10, drive 2", status is OK. 27-Oct 23:30 uklxhome0-sd JobId 550: Volume "LX0018" previously written, moving to end of data. 27-Oct 23:31 uklxhome0-sd JobId 550: Ready to append to end of Volume "LX0018" at file=1123. 27-Oct 23:31 uklxhome0-sd JobId 550: Spooling data ... 27-Oct 23:37 uklxblade0-fd JobId 550: shell command: run ClientAfterJob "/etc/bacula/postgres_post.sh" 27-Oct 23:37 uklxhome0-sd JobId 550: Job write elapsed time = 00:05:03, Transfer rate = 4.897 M bytes/second 27-Oct 23:37 uklxhome0-sd JobId 550: Committing spooled data to Volume "LX0018". Despooling 1,485,971,274 bytes ... 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxblade0-fd JobId 550: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 27-Oct 23:37 uklxhome0-sd JobId 550: Despooling elapsed time = 00:00:22, Transfer rate = 67.54 M bytes/second 27-Oct 23:37 uklxhome0-sd JobId 550: Sending spooled attrs to the Director. Despooling 3,876 bytes ... 27-Oct 23:37 uklxhome0-dir JobId 550: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:37:36 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 550 Job: uklxblade0-db.2009-10-27_23.05.00_10 Backup Level: Full Client: "uklxblade0-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxblade0-db-set" 2009-10-13 14:55:50 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:08:43 End time: 27-Oct-2009 23:37:36 Elapsed time: 28 mins 53 secs Priority: 10 FD Files Written: 19 SD Files Written: 19 FD Bytes Written: 1,483,917,862 (1.483 GB) SD Bytes Written: 1,483,919,998 (1.483 GB) Rate: 856.3 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0018 Volume Session Id: 5 Volume Session Time: 1256658721 Last Volume Bytes: 1,123,568,169,984 (1.123 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:37 uklxhome0-dir JobId 550: Begin pruning Jobs. 27-Oct 23:37 uklxhome0-dir JobId 550: No Jobs found to prune. 27-Oct 23:37 uklxhome0-dir JobId 550: Begin pruning Files. 27-Oct 23:37 uklxhome0-dir JobId 550: No Files found to prune. 27-Oct 23:37 uklxhome0-dir JobId 550: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 556: Start Backup JobId 556, Job=uklxmodel1_flood-EU_FLOOD-job.2009-10-27_23.05.00_16 27-Oct 23:07 uklxhome0-dir JobId 556: Using Device "Drive-0" 27-Oct 23:46 uklxhome0-sd JobId 556: Job write elapsed time = 00:12:11, Transfer rate = 67.63 M bytes/second 27-Oct 23:48 uklxhome0-dir JobId 556: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:48:40 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 556 Job: uklxmodel1_flood-EU_FLOOD-job.2009-10-27_23.05.00_16 Backup Level: Incremental, since=2009-10-26 23:06:20 Client: "uklxmodel1-fd" 2.2.8 (26Jan08) x86_64-pc-linux-gnu,debian,lenny/sid FileSet: "uklxmodel1_flood-EU_FLOOD-set" 2009-10-05 17:35:49 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:07:54 End time: 27-Oct-2009 23:48:40 Elapsed time: 40 mins 46 secs Priority: 10 FD Files Written: 1,687 SD Files Written: 1,687 FD Bytes Written: 49,444,049,973 (49.44 GB) SD Bytes Written: 49,444,329,901 (49.44 GB) Rate: 20214.2 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0020 Volume Session Id: 11 Volume Session Time: 1256658721 Last Volume Bytes: 457,059,618,816 (457.0 GB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:48 uklxhome0-dir JobId 556: Begin pruning Jobs. 27-Oct 23:48 uklxhome0-dir JobId 556: No Jobs found to prune. 27-Oct 23:48 uklxhome0-dir JobId 556: Begin pruning Files. 27-Oct 23:48 uklxhome0-dir JobId 556: No Files found to prune. 27-Oct 23:48 uklxhome0-dir JobId 556: End auto prune. 27-Oct 23:35 uklxhome0-dir JobId 566: Start Backup JobId 566, Job=xyratex_m5home_job.2009-10-27_23.05.00_26 27-Oct 23:35 uklxhome0-dir JobId 566: Using Device "Drive-2" 27-Oct 23:51 uklxhome0-sd JobId 566: Job write elapsed time = 00:16:03, Transfer rate = 42.46 M bytes/second 27-Oct 23:56 uklxhome0-dir JobId 566: Bacula uklxhome0-dir 3.0.3 (18Oct09): 27-Oct-2009 23:56:41 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 566 Job: xyratex_m5home_job.2009-10-27_23.05.00_26 Backup Level: Incremental, since=2009-10-26 23:10:11 Client: "uklxfs2-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "xyratex_m5home_set" 2009-10-01 14:06:03 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:35:11 End time: 27-Oct-2009 23:56:41 Elapsed time: 21 mins 30 secs Priority: 10 FD Files Written: 11,819 SD Files Written: 11,819 FD Bytes Written: 40,888,302,625 (40.88 GB) SD Bytes Written: 40,890,476,789 (40.89 GB) Rate: 31696.4 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0018 Volume Session Id: 21 Volume Session Time: 1256658721 Last Volume Bytes: 1,160,957,271,040 (1.160 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 27-Oct 23:56 uklxhome0-dir JobId 566: Begin pruning Jobs. 27-Oct 23:56 uklxhome0-dir JobId 566: No Jobs found to prune. 27-Oct 23:56 uklxhome0-dir JobId 566: Begin pruning Files. 27-Oct 23:56 uklxhome0-dir JobId 566: No Files found to prune. 27-Oct 23:56 uklxhome0-dir JobId 566: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 557: Start Backup JobId 557, Job=uklxmodel1_flood-flood1_Backup-job.2009-10-27_23.05.00_17 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0031" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0032" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0033" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0034" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0035" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0036" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0037" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0038" from 'Scratch' pool. 27-Oct 23:08 uklxhome0-dir JobId 557: Using Volume "LX0039" from 'Scratch' pool. 27-Oct 23:31 uklxhome0-dir JobId 557: Using Device "Drive-2" 28-Oct 00:16 uklxhome0-sd JobId 557: Job write elapsed time = 00:44:10, Transfer rate = 0 bytes/second 28-Oct 00:16 uklxhome0-dir JobId 557: Bacula uklxhome0-dir 3.0.3 (18Oct09): 28-Oct-2009 00:16:08 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 557 Job: uklxmodel1_flood-flood1_Backup-job.2009-10-27_23.05.00_17 Backup Level: Incremental, since=2009-10-26 23:06:20 Client: "uklxmodel1-fd" 2.2.8 (26Jan08) x86_64-pc-linux-gnu,debian,lenny/sid FileSet: "uklxmodel1_flood-flood1_Backup-set" 2009-10-05 17:35:53 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:31:58 End time: 28-Oct-2009 00:16:08 Elapsed time: 44 mins 10 secs Priority: 10 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: 12 Volume Session Time: 1256658721 Last Volume Bytes: 1,160,957,272,064 (1.160 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 28-Oct 00:16 uklxhome0-dir JobId 557: Begin pruning Jobs. 28-Oct 00:16 uklxhome0-dir JobId 557: No Jobs found to prune. 28-Oct 00:16 uklxhome0-dir JobId 557: Begin pruning Files. 28-Oct 00:16 uklxhome0-dir JobId 557: No Files found to prune. 28-Oct 00:16 uklxhome0-dir JobId 557: End auto prune. 27-Oct 23:05 uklxhome0-dir JobId 559: Start Backup JobId 559, Job=uklxmodel1_flood-uklxmodel2-job.2009-10-27_23.05.00_19 27-Oct 23:34 uklxhome0-dir JobId 559: Using Device "Drive-2" 28-Oct 00:23 uklxhome0-sd JobId 559: Job write elapsed time = 00:49:17, Transfer rate = 0 bytes/second 28-Oct 00:23 uklxhome0-dir JobId 559: Bacula uklxhome0-dir 3.0.3 (18Oct09): 28-Oct-2009 00:23:55 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 559 Job: uklxmodel1_flood-uklxmodel2-job.2009-10-27_23.05.00_19 Backup Level: Incremental, since=2009-10-26 23:09:18 Client: "uklxmodel1-fd" 2.2.8 (26Jan08) x86_64-pc-linux-gnu,debian,lenny/sid FileSet: "uklxmodel1_flood-uklxmodel2-set" 2009-10-07 11:44:12 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:34:33 End time: 28-Oct-2009 00:23:55 Elapsed time: 49 mins 22 secs Priority: 10 FD Files Written: 4 SD Files Written: 4 FD Bytes Written: 1,547 (1.547 KB) SD Bytes Written: 2,086 (2.086 KB) Rate: 0.0 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0018 Volume Session Id: 14 Volume Session Time: 1256658721 Last Volume Bytes: 1,160,957,275,136 (1.160 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 28-Oct 00:23 uklxhome0-dir JobId 559: Begin pruning Jobs. 28-Oct 00:23 uklxhome0-dir JobId 559: No Jobs found to prune. 28-Oct 00:23 uklxhome0-dir JobId 559: Begin pruning Files. 28-Oct 00:23 uklxhome0-dir JobId 559: No Files found to prune. 28-Oct 00:23 uklxhome0-dir JobId 559: End auto prune. 27-Oct 17:06 uklxhome0-dir JobId 547: Start Backup JobId 547, Job=uklxblade0_euwind_job.2009-10-27_17.06.19_07 27-Oct 17:06 uklxhome0-dir JobId 547: Using Volume "LX0029" from 'Scratch' pool. 27-Oct 17:06 uklxhome0-dir JobId 547: Using Device "Drive-1" 27-Oct 17:06 uklxhome0-sd JobId 547: 3301 Issuing autochanger "loaded? drive 1" command. 27-Oct 17:06 uklxhome0-sd JobId 547: 3302 Autochanger "loaded? drive 1", result: nothing loaded. 27-Oct 17:06 uklxhome0-sd JobId 547: 3304 Issuing autochanger "load slot 21, drive 1" command. 27-Oct 17:07 uklxhome0-sd JobId 547: 3305 Autochanger "load slot 21, drive 1", status is OK. 27-Oct 17:07 uklxhome0-sd JobId 547: Error: block.c:1010 Read error on fd=7 at file:blk 0:0 on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). ERR=Input/output error. 27-Oct 17:07 uklxhome0-sd JobId 547: Labeled new Volume "LX0029" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). 27-Oct 17:07 uklxhome0-sd JobId 547: Wrote label to prelabeled Volume "LX0029" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst) 27-Oct 20:52 uklxhome0-sd JobId 547: End of Volume "LX0029" at 917:597 on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). Write of 1048576 bytes got -1. 27-Oct 20:52 uklxhome0-sd JobId 547: Re-read of last block succeeded. 27-Oct 20:52 uklxhome0-sd JobId 547: End of medium on Volume "LX0029" Bytes=916,977,615,872 Blocks=874,498 at 27-Oct-2009 20:52. 27-Oct 20:52 uklxhome0-sd JobId 547: 3307 Issuing autochanger "unload slot 21, drive 1" command. 27-Oct 20:54 uklxhome0-dir JobId 547: Using Volume "LX0030" from 'Scratch' pool. 27-Oct 20:54 uklxhome0-sd JobId 547: 3301 Issuing autochanger "loaded? drive 1" command. 27-Oct 20:54 uklxhome0-sd JobId 547: 3302 Autochanger "loaded? drive 1", result: nothing loaded. 27-Oct 20:54 uklxhome0-sd JobId 547: 3304 Issuing autochanger "load slot 22, drive 1" command. 27-Oct 20:55 uklxhome0-sd JobId 547: 3305 Autochanger "load slot 22, drive 1", status is OK. 27-Oct 20:55 uklxhome0-sd JobId 547: Error: block.c:1010 Read error on fd=7 at file:blk 0:0 on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). ERR=Input/output error. 27-Oct 20:55 uklxhome0-sd JobId 547: Labeled new Volume "LX0030" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). 27-Oct 20:55 uklxhome0-sd JobId 547: Wrote label to prelabeled Volume "LX0030" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst) 27-Oct 20:55 uklxhome0-sd JobId 547: New volume "LX0030" mounted on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst) at 27-Oct-2009 20:55. 28-Oct 00:53 uklxhome0-sd JobId 547: End of Volume "LX0030" at 872:632 on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). Write of 1048576 bytes got -1. 28-Oct 00:53 uklxhome0-sd JobId 547: Re-read of last block succeeded. 28-Oct 00:53 uklxhome0-sd JobId 547: End of medium on Volume "LX0030" Bytes=872,046,134,272 Blocks=831,648 at 28-Oct-2009 00:53. 28-Oct 00:53 uklxhome0-sd JobId 547: 3307 Issuing autochanger "unload slot 22, drive 1" command. 28-Oct 00:54 uklxhome0-dir JobId 547: Using Volume "LX0040" from 'Scratch' pool. 28-Oct 00:54 uklxhome0-sd JobId 547: 3301 Issuing autochanger "loaded? drive 1" command. 28-Oct 00:54 uklxhome0-sd JobId 547: 3302 Autochanger "loaded? drive 1", result: nothing loaded. 28-Oct 00:54 uklxhome0-sd JobId 547: 3304 Issuing autochanger "load slot 32, drive 1" command. 28-Oct 00:55 uklxhome0-sd JobId 547: 3305 Autochanger "load slot 32, drive 1", status is OK. 28-Oct 00:55 uklxhome0-sd JobId 547: Error: block.c:1010 Read error on fd=7 at file:blk 0:0 on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). ERR=Input/output error. 28-Oct 00:55 uklxhome0-sd JobId 547: Labeled new Volume "LX0040" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). 28-Oct 00:55 uklxhome0-sd JobId 547: Wrote label to prelabeled Volume "LX0040" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst) 28-Oct 00:55 uklxhome0-sd JobId 547: New volume "LX0040" mounted on device "Drive-1" (/dev/tape/by-id/scsi-327-Oct 23:35 uklxhome0-dir JobId 564: Start Backup JobId 564, Job=uklxmodel5-db.2009-10-27_23.05.00_24 27-Oct 23:35 uklxhome0-dir JobId 564: Using Device "Drive-2" 27-Oct 23:35 uklxmodel5-fd JobId 564: shell command: run ClientRunBeforeJob "/etc/bacula/postgres_pre.sh" 27-Oct 23:35 uklxhome0-sd JobId 564: Spooling data ... 28-Oct 01:42 uklxhome0-sd JobId 564: Job write elapsed time = 02:07:11, Transfer rate = 1.523 M bytes/second 28-Oct 01:42 uklxmodel5-fd JobId 564: shell command: run ClientAfterJob "/etc/bacula/postgres_post.sh" 28-Oct 01:42 uklxhome0-sd JobId 564: Committing spooled data to Volume "LX0018". Despooling 11,647,030,464 bytes ... 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:42 uklxmodel5-fd JobId 564: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 01:44 uklxhome0-sd JobId 564: Despooling elapsed time = 00:02:12, Transfer rate = 88.23 M bytes/second 28-Oct 01:44 uklxhome0-sd JobId 564: Sending spooled attrs to the Director. Despooling 20,919 bytes ... 28-Oct 01:45 uklxhome0-dir JobId 564: Bacula uklxhome0-dir 3.0.3 (18Oct09): 28-Oct-2009 01:45:02 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 564 Job: uklxmodel5-db.2009-10-27_23.05.00_24 Backup Level: Full Client: "uklxmodel5-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxmodel5-db-set" 2009-10-13 13:59:02 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:35:08 End time: 28-Oct-2009 01:45:02 Elapsed time: 2 hours 9 mins 54 secs Priority: 10 FD Files Written: 103 SD Files Written: 103 FD Bytes Written: 11,628,790,489 (11.62 GB) SD Bytes Written: 11,628,802,360 (11.62 GB) Rate: 1492.0 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0018 Volume Session Id: 19 Volume Session Time: 1256658721 Last Volume Bytes: 1,172,604,173,312 (1.172 TB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 28-Oct 01:45 uklxhome0-dir JobId 564: Begin pruning Jobs. 28-Oct 01:45 uklxhome0-dir JobId 564: No Jobs found to prune. 28-Oct 01:45 uklxhome0-dir JobId 564: Begin pruning Files. 28-Oct 01:45 uklxhome0-dir JobId 564: No Files found to prune. 28-Oct 01:45 uklxhome0-dir JobId 564: End auto prune. 27-Oct 23:35 uklxhome0-dir JobId 563: Start Backup JobId 563, Job=uklxmodel4-db.2009-10-27_23.05.00_23 27-Oct 23:35 uklxhome0-dir JobId 563: Using Device "Drive-4" 27-Oct 23:35 uklxmodel4-fd JobId 563: shell command: run ClientRunBeforeJob "/etc/bacula/postgres_pre.sh" 27-Oct 23:35 uklxhome0-sd JobId 563: Spooling data ... 28-Oct 02:15 uklxhome0-sd JobId 563: Job write elapsed time = 02:40:36, Transfer rate = 844.1 K bytes/second 28-Oct 02:15 uklxmodel4-fd JobId 563: shell command: run ClientAfterJob "/etc/bacula/postgres_post.sh" 28-Oct 02:15 uklxhome0-sd JobId 563: Committing spooled data to Volume "LX0021". Despooling 8,149,978,354 bytes ... 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:15 uklxmodel4-fd JobId 563: ClientAfterJob: kill: usage: kill [-s sigspec | -n signum | -sigspec] pid | jobspec ... or kill -l [sigspec] 28-Oct 02:17 uklxhome0-sd JobId 563: Despooling elapsed time = 00:01:59, Transfer rate = 68.48 M bytes/second 28-Oct 02:17 uklxhome0-sd JobId 563: Sending spooled attrs to the Director. Despooling 4,999 bytes ... 28-Oct 02:18 uklxhome0-dir JobId 563: Bacula uklxhome0-dir 3.0.3 (18Oct09): 28-Oct-2009 02:18:00 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 563 Job: uklxmodel4-db.2009-10-27_23.05.00_23 Backup Level: Full Client: "uklxmodel4-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxmodel4-db-set" 2009-10-13 11:10:05 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 27-Oct-2009 23:35:07 End time: 28-Oct-2009 02:18:00 Elapsed time: 2 hours 42 mins 53 secs Priority: 10 FD Files Written: 25 SD Files Written: 25 FD Bytes Written: 8,134,536,013 (8.134 GB) SD Bytes Written: 8,134,538,750 (8.134 GB) Rate: 832.3 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0021 Volume Session Id: 18 Volume Session Time: 1256658721 Last Volume Bytes: 11,432,810,496 (11.43 GB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 28-Oct 02:18 uklxhome0-dir JobId 563: Begin pruning Jobs. 28-Oct 02:18 uklxhome0-dir JobId 563: No Jobs found to prune. 28-Oct 02:18 uklxhome0-dir JobId 563: Begin pruning Files. 28-Oct 02:18 uklxhome0-dir JobId 563: No Files found to prune. 28-Oct 02:18 uklxhome0-dir JobId 563: End auto prune. 500308c09f221094-nst) at 28-Oct-2009 00:55. 28-Oct 04:22 uklxhome0-sd JobId 547: End of Volume "LX0040" at 851:816 on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). Write of 1048576 bytes got -1. 28-Oct 04:22 uklxhome0-sd JobId 547: Re-read of last block succeeded. 28-Oct 04:22 uklxhome0-sd JobId 547: End of medium on Volume "LX0040" Bytes=851,253,920,768 Blocks=811,819 at 28-Oct-2009 04:22. 28-Oct 04:22 uklxhome0-sd JobId 547: 3307 Issuing autochanger "unload slot 32, drive 1" command. 28-Oct 04:23 uklxhome0-dir JobId 547: Using Volume "LX0041" from 'Scratch' pool. 28-Oct 04:23 uklxhome0-sd JobId 547: 3301 Issuing autochanger "loaded? drive 1" command. 28-Oct 04:24 uklxhome0-sd JobId 547: 3302 Autochanger "loaded? drive 1", result: nothing loaded. 28-Oct 04:24 uklxhome0-sd JobId 547: 3304 Issuing autochanger "load slot 33, drive 1" command. 28-Oct 04:25 uklxhome0-sd JobId 547: 3305 Autochanger "load slot 33, drive 1", status is OK. 28-Oct 04:25 uklxhome0-sd JobId 547: Error: block.c:1010 Read error on fd=7 at file:blk 0:0 on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). ERR=Input/output error. 28-Oct 04:25 uklxhome0-sd JobId 547: Labeled new Volume "LX0041" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst). 28-Oct 04:25 uklxhome0-sd JobId 547: Wrote label to prelabeled Volume "LX0041" on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst) 28-Oct 04:25 uklxhome0-sd JobId 547: New volume "LX0041" mounted on device "Drive-1" (/dev/tape/by-id/scsi-3500308c09f221094-nst) at 28-Oct-2009 04:25. 28-Oct 06:02 uklxhome0-sd JobId 547: Job write elapsed time = 12:48:03, Transfer rate = 65.98 M bytes/second 28-Oct 06:02 uklxhome0-sd JobId 547: Alert: TapeAlert[31]: Hardware B: Tape drive has a problem not read/write related. 28-Oct 06:03 uklxhome0-dir JobId 547: Bacula uklxhome0-dir 3.0.3 (18Oct09): 28-Oct-2009 06:03:15 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 547 Job: uklxblade0_euwind_job.2009-10-27_17.06.19_07 Backup Level: Full Client: "uklxblade0-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxblade0_euwind_set" 2009-10-13 14:48:12 Pool: "ARCHIVE" (From User input) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 17:05:41 Start time: 27-Oct-2009 17:06:21 End time: 28-Oct-2009 06:03:15 Elapsed time: 12 hours 56 mins 54 secs Priority: 10 FD Files Written: 110,590 SD Files Written: 110,590 FD Bytes Written: 3,040,658,354,433 (3.040 TB) SD Bytes Written: 3,040,678,536,918 (3.040 TB) Rate: 65230.6 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): LX0029|LX0030|LX0040|LX0041 Volume Session Id: 3 Volume Session Time: 1256658721 Last Volume Bytes: 401,065,364,480 (401.0 GB) Non-fatal FD errors: 0 SD Errors: 4 FD termination status: OK SD termination status: OK Termination: Backup OK -- with warnings 28-Oct 06:03 uklxhome0-dir JobId 547: Begin pruning Jobs. 28-Oct 06:03 uklxhome0-dir JobId 547: No Jobs found to prune. 28-Oct 06:03 uklxhome0-dir JobId 547: Begin pruning Files. 28-Oct 06:03 uklxhome0-dir JobId 547: No Files found to prune. 28-Oct 06:03 uklxhome0-dir JobId 547: End auto prune. 28-Oct 06:03 uklxhome0-dir JobId 549: Start Backup JobId 549, Job=uklxblade0_euwind_job.2009-10-27_23.05.00_09 28-Oct 06:03 uklxhome0-dir JobId 549: Using Device "Drive-0" 28-Oct 06:03 uklxhome0-sd JobId 549: 3307 Issuing autochanger "unload slot 13, drive 4" command. 28-Oct 06:05 uklxhome0-sd JobId 549: 3307 Issuing autochanger "unload slot 12, drive 0" command. 28-Oct 06:07 uklxhome0-sd JobId 549: 3304 Issuing autochanger "load slot 13, drive 0" command. 28-Oct 06:08 uklxhome0-sd JobId 549: 3305 Autochanger "load slot 13, drive 0", status is OK. 28-Oct 06:08 uklxhome0-sd JobId 549: Volume "LX0021" previously written, moving to end of data. 28-Oct 06:09 uklxhome0-sd JobId 549: Ready to append to end of Volume "LX0021" at file=15. 28-Oct 06:09 uklxhome0-sd JobId 549: Job write elapsed time = 00:00:01, Transfer rate = 0 bytes/second 28-Oct 06:09 uklxhome0-dir JobId 549: Bacula uklxhome0-dir 3.0.3 (18Oct09): 28-Oct-2009 06:09:34 Build OS: x86_64-suse-linux-gnu suse 10 JobId: 549 Job: uklxblade0_euwind_job.2009-10-27_23.05.00_09 Backup Level: Incremental, since=2009-10-26 23:05:02 Client: "uklxblade0-fd" 3.0.2 (18Jul09) x86_64-suse-linux-gnu,suse,10 FileSet: "uklxblade0_euwind_set" 2009-10-13 14:48:12 Pool: "Week4" (From Run pool override) Catalog: "MyCatalog" (From Client resource) Storage: "Dell-ML6000" (From Job resource) Scheduled time: 27-Oct-2009 23:05:00 Start time: 28-Oct-2009 06:03:19 End time: 28-Oct-2009 06:09:34 Elapsed time: 6 mins 15 secs Priority: 10 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): LX0021 Volume Session Id: 22 Volume Session Time: 1256658721 Last Volume Bytes: 11,432,811,520 (11.43 GB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK 28-Oct 06:09 uklxhome0-dir JobId 549: Begin pruning Jobs. 28-Oct 06:09 uklxhome0-dir JobId 549: No Jobs found to prune. 28-Oct 06:09 uklxhome0-dir JobId 549: Begin pruning Files. 28-Oct 06:09 uklxhome0-dir JobId 549: No Files found to prune. 28-Oct 06:09 uklxhome0-dir JobId 549: End auto prune.