| Time | Event |
|---|---|
| 2017-06-14 01:00:01 | bacula-dir JobId 30160: Start Backup JobId 30160, Job=Users_e-f.2017-06-14_01.00.00_46 |
| 2017-06-14 01:00:01 | bacula-dir JobId 30160: Using Device "ULT3580-TD5" to write. |
| 2017-06-14 01:00:18 | bacula-sd JobId 30160: Volume "L50002L5" previously written, moving to end of data. |
| 2017-06-14 01:00:51 | bacula-sd JobId 30160: Ready to append to end of Volume "L50002L5" at file=2714. |
| 2017-06-14 01:00:51 | bacula-sd JobId 30160: Spooling data ... |
| 2017-06-14 01:05:23 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,330,543,066 bytes ... |
| 2017-06-14 01:08:07 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:44, Transfer rate = 38.60 M Bytes/second |
| 2017-06-14 01:10:15 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,330,280,912 bytes ... |
| 2017-06-14 01:12:35 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:20, Transfer rate = 45.21 M Bytes/second |
| 2017-06-14 01:14:43 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,330,280,932 bytes ... |
| 2017-06-14 01:16:54 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:11, Transfer rate = 48.32 M Bytes/second |
| 2017-06-14 01:22:48 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,303,016,617 bytes ... |
| 2017-06-14 01:25:17 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:29, Transfer rate = 42.30 M Bytes/second |
| 2017-06-14 01:27:25 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,303,016,697 bytes ... |
| 2017-06-14 01:30:08 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:43, Transfer rate = 38.66 M Bytes/second |
| 2017-06-14 01:32:43 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,302,230,213 bytes ... |
| 2017-06-14 01:35:17 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:34, Transfer rate = 40.92 M Bytes/second |
| 2017-06-14 01:38:30 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,298,822,157 bytes ... |
| 2017-06-14 01:40:44 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:14, Transfer rate = 47.00 M Bytes/second |
| 2017-06-14 01:43:28 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,296,987,107 bytes ... |
| 2017-06-14 01:45:57 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:29, Transfer rate = 42.26 M Bytes/second |
| 2017-06-14 01:48:44 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,294,627,708 bytes ... |
| 2017-06-14 01:49:48 | bacula-sd JobId 30160: End of Volume "L50002L5" at 2767:2764 on device "ULT3580-TD5" (/dev/nst0). Write of 262144 bytes got -1. |
| 2017-06-14 01:49:55 | bacula-sd JobId 30160: Re-read of last block succeeded. |
| 2017-06-14 01:49:55 | bacula-sd JobId 30160: End of medium on Volume "L50002L5" Bytes=2,758,213,089,280 Blocks=3,829,577 at 14-Jun-2017 01:49. |
| 2017-06-14 01:49:58 | bacula-sd JobId 30160: 3307 Issuing autochanger "unload slot 50, drive 0" command. |
| 2017-06-14 01:50:41 | bacula-sd JobId 30160: 3304 Issuing autochanger "load slot 5, drive 0" command. |
| 2017-06-14 01:50:57 | bacula-sd JobId 30160: 3305 Autochanger "load slot 5, drive 0", status is OK. |
| 2017-06-14 01:51:03 | bacula-sd JobId 30160: Wrote label to prelabeled Volume "L50004L5" on tape device "ULT3580-TD5" (/dev/nst0) |
| 2017-06-14 01:51:03 | bacula-sd JobId 30160: New volume "L50004L5" mounted on device "ULT3580-TD5" (/dev/nst0) at 14-Jun-2017 01:51. |
| 2017-06-14 01:52:15 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:23, Transfer rate = 44.01 M Bytes/second |
| 2017-06-14 01:57:36 | bacula-sd JobId 30160: Writing spooled data to Volume. Despooling 6,282,830,659 bytes ... |
| 2017-06-14 02:00:01 | bacula-sd JobId 30160: Despooling elapsed time = 00:02:25, Transfer rate = 43.32 M Bytes/second |
| 2017-06-14 02:02:05 | bacula-sd JobId 30160: Committing spooled data to Volume "L50004L5". Despooling 5,076,041,525 bytes ... |
| 2017-06-14 02:03:32 | bacula-sd JobId 30160: Despooling elapsed time = 00:01:27, Transfer rate = 58.34 M Bytes/second |
| 2017-06-14 02:03:33 | bacula-sd JobId 30160: Elapsed time=01:01:34, Transfer rate=18.44 M Bytes/second |
| 2017-06-14 02:04:53 | bacula-sd JobId 30160: Sending spooled attrs to the Director. Despooling 65,596,768 bytes ... |
| 2017-06-14 02:05:38 | bacula-dir JobId 30160: Bacula bacula-dir 7.0.5 (28Jul14): Build OS: x86_64-pc-linux-gnu ubuntu 16.04 JobId: 30160 Job: Users_e-f.2017-06-14_01.00.00_46 Backup Level: Incremental, since=2017-05-10 01:00:00 Client: "gpfscsic05-fd" 5.0.0 (26Jan10) x86_64-redhat-linux-gnu,redhat,(Carbon) FileSet: "Users_e-f" 2015-01-14 01:00:00 Pool: "Users" (From Job resource) Catalog: "MyCatalog" (From Client resource) Storage: "TSM3500-LTO5" (From Job resource) Scheduled time: 14-Jun-2017 01:00:00 Start time: 14-Jun-2017 01:00:01 End time: 14-Jun-2017 02:05:38 Elapsed time: 1 hour 5 mins 37 secs Priority: 10 FD Files Written: 269,225 SD Files Written: 269,225 FD Bytes Written: 68,075,115,820 (68.07 GB) SD Bytes Written: 68,118,366,913 (68.11 GB) Rate: 17291.1 KB/s Software Compression: None VSS: no Encryption: no Accurate: no Volume name(s): L50002L5|L50004L5 Volume Session Id: 742 Volume Session Time: 1494578088 Last Volume Bytes: 14,430,681,088 (14.43 GB) Non-fatal FD errors: 0 SD Errors: 0 FD termination status: OK SD termination status: OK Termination: Backup OK |
| 2017-06-14 02:05:39 | bacula-dir JobId 30160: Begin pruning Jobs older than 6 months . |
| 2017-06-14 02:05:39 | bacula-dir JobId 30160: No Jobs found to prune. |
| 2017-06-14 02:05:39 | bacula-dir JobId 30160: Begin pruning Files. |
| 2017-06-14 02:05:39 | bacula-dir JobId 30160: No Files found to prune. |
| 2017-06-14 02:05:39 | bacula-dir JobId 30160: End auto prune. |