Backup agent for Linux servers and workstations on-premises or in the public cloud
Post Reply
eazaika
Lurker
Posts: 1
Liked: never
Joined: Jan 14, 2019 10:05 am
Full Name: Ekaterina Zaika
Contact:

Failed auto recover job. Server overload

Post by eazaika » Jan 14, 2019 10:31 am

My recovery job automatically started at 5 a.m., but something going wrong. There is no errors in the log, but ubuntu server froze. After shutdown and restart job everything worked out. But WTF? Why it crashed? Where are the errors?

Image

/var/log/veeam/Backup/BackupJob/Session_20190113_050001_\{8ad64c4a-ccf8-4664-a1d2-51e90b927548\}/Job.log

Code: Select all

[13.01.2019 05:00:21] <140460756543232> lpbcore| Accurate disk size: 375809638400
[13.01.2019 05:00:21] <140460756543232> lpbcore| Session progress: 0%; processed size: 1048576 processing speed: 77328 bottleneck stats: 98/11/0/0
[13.01.2019 05:00:21] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1 MB at 428.5 KB/s (0%).
[13.01.2019 05:00:26] <140460756543232> lpbcore| Session progress: 0%; processed size: 224395264 processing speed: 12515073 bottleneck stats: 89/14/0/11
[13.01.2019 05:00:26] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 214 MB at 31.7 MB/s (0%).
[13.01.2019 05:00:27] <140460756543232> lpbcore| Session progress: 0%; processed size: 242221056 processing speed: 12855379 bottleneck stats: 89/14/0/14
[13.01.2019 05:00:27] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 231 MB at 30.1 MB/s (0%).
[13.01.2019 05:00:27] <140460756543232> lpbcore| Session progress: 0%; processed size: 248512512 processing speed: 12992759 bottleneck stats: 89/14/0/14
[13.01.2019 05:00:27] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 237 MB at 29.8 MB/s (0%).
[13.01.2019 05:00:27] <140460756543232> lpbcore| Session progress: 0%; processed size: 251658240 processing speed: 13088793 bottleneck stats: 89/14/0/14
[13.01.2019 05:00:27] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 240 MB at 29.8 MB/s (0%).
[13.01.2019 05:00:35] <140460756543232> lpbcore| Session progress: 0%; processed size: 513802240 processing speed: 18897430 bottleneck stats: 89/17/0/14
[13.01.2019 05:00:35] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 490 MB at 30.6 MB/s (0%).
[13.01.2019 05:00:36] <140460756543232> lpbcore| Session progress: 1%; processed size: 584056832 processing speed: 20366734 bottleneck stats: 89/19/0/17
[13.01.2019 05:00:36] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 557 MB at 31.8 MB/s (1%).
[13.01.2019 05:00:36] <140460756543232> lpbcore| Session progress: 1%; processed size: 585105408 processing speed: 20396186 bottleneck stats: 89/19/0/17
[13.01.2019 05:00:36] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 558 MB at 31.9 MB/s (1%).
[13.01.2019 05:00:36] <140460756543232> lpbcore| Session progress: 1%; processed size: 587202560 processing speed: 20439366 bottleneck stats: 89/19/0/17
[13.01.2019 05:00:36] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 560 MB at 31.9 MB/s (1%).
[13.01.2019 05:00:43] <140460756543232> lpbcore| Session progress: 1%; processed size: 706740224 processing speed: 20329073 bottleneck stats: 89/22/0/19
[13.01.2019 05:00:43] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 674 MB at 28.6 MB/s (1%).
[13.01.2019 05:00:44] <140460756543232> lpbcore| Session progress: 1%; processed size: 737148928 processing speed: 20132979 bottleneck stats: 89/22/0/22
[13.01.2019 05:00:44] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 703 MB at 27.6 MB/s (1%).
[13.01.2019 05:00:48] <140460756543232> lpbcore| Session progress: 1%; processed size: 810549248 processing speed: 20136368 bottleneck stats: 89/24/0/22
[13.01.2019 05:00:48] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 773 MB at 26.6 MB/s (1%).
[13.01.2019 05:00:55] <140460756543232> lpbcore| Session progress: 1%; processed size: 926941184 processing speed: 19642746 bottleneck stats: 89/26/0/24
[13.01.2019 05:00:55] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 884 MB at 24.5 MB/s (1%).
[13.01.2019 05:01:03] <140460756543232> lpbcore| Session progress: 2%; processed size: 1142947840 processing speed: 20855951 bottleneck stats: 89/34/0/26
[13.01.2019 05:01:03] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.1 GB at 25 MB/s (2%).
[13.01.2019 05:01:10] <140460756543232> lpbcore| Session progress: 2%; processed size: 1282408448 processing speed: 20730818 bottleneck stats: 89/35/0/34
[13.01.2019 05:01:10] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.2 GB at 24.1 MB/s (2%).
[13.01.2019 05:01:12] <140460756543232> lpbcore| Session progress: 2%; processed size: 1336934400 processing speed: 20864497 bottleneck stats: 89/36/0/35
[13.01.2019 05:01:12] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.2 GB at 24.1 MB/s (2%).
[13.01.2019 05:01:16] <140460756543232> lpbcore| Session progress: 2%; processed size: 1432354816 processing speed: 21068688 bottleneck stats: 89/37/0/36
[13.01.2019 05:01:16] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.3 GB at 24 MB/s (2%).
[13.01.2019 05:01:17] <140460756543232> lpbcore| Session progress: 2%; processed size: 1462763520 processing speed: 21039086 bottleneck stats: 89/37/0/37
[13.01.2019 05:01:17] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.4 GB at 23.9 MB/s (2%).
[13.01.2019 05:01:21] <140460756543232> lpbcore| Session progress: 2%; processed size: 1541406720 processing speed: 21178696 bottleneck stats: 89/38/0/37
[13.01.2019 05:01:21] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.4 GB at 23.9 MB/s (2%).
[13.01.2019 05:01:21] <140460756543232> lpbcore| Session progress: 2%; processed size: 1547698176 processing speed: 21166261 bottleneck stats: 89/38/0/37
[13.01.2019 05:01:21] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.4 GB at 23.8 MB/s (2%).
[13.01.2019 05:01:24] <140460756543232> lpbcore| Session progress: 3%; processed size: 1607467008 processing speed: 20971520 bottleneck stats: 89/38/0/38
[13.01.2019 05:01:24] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.5 GB at 23.4 MB/s (3%).
[13.01.2019 05:01:27] <140460756543232> lpbcore| Session progress: 3%; processed size: 1677721600 processing speed: 21114305 bottleneck stats: 89/39/0/38
[13.01.2019 05:01:27] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.6 GB at 23.4 MB/s (3%).
[13.01.2019 05:01:32] <140460756543232> lpbcore| Session progress: 3%; processed size: 1763704832 processing speed: 21053129 bottleneck stats: 89/40/0/39
[13.01.2019 05:01:32] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.6 GB at 23.2 MB/s (3%).
[13.01.2019 05:01:32] <140460756543232> lpbcore| Session progress: 3%; processed size: 1788870656 processing speed: 21147042 bottleneck stats: 89/40/0/40
[13.01.2019 05:01:32] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.7 GB at 23.2 MB/s (3%).
[13.01.2019 05:01:33] <140460756543232> lpbcore| Session progress: 3%; processed size: 1802502144 processing speed: 21153149 bottleneck stats: 89/40/0/40
[13.01.2019 05:01:33] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.7 GB at 23.2 MB/s (3%).
[13.01.2019 05:01:33] <140460756543232> lpbcore| Session progress: 3%; processed size: 1806696448 processing speed: 21148762 bottleneck stats: 89/40/0/40
[13.01.2019 05:01:33] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.7 GB at 23.2 MB/s (3%).
[13.01.2019 05:01:33] <140460756543232> lpbcore| Session progress: 3%; processed size: 1809842176 processing speed: 21163041 bottleneck stats: 89/40/0/40
[13.01.2019 05:01:33] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 1.7 GB at 23.2 MB/s (3%).
[13.01.2019 05:01:37] <140460756543232> lpbcore| Session progress: 8%; processed size: 4490002432 processing speed: 50502805 bottleneck stats: 86/53/0/40
[13.01.2019 05:01:37] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 4.2 GB at 55.1 MB/s (8%).
[13.01.2019 05:01:42] <140460756543232> lpbcore| Session progress: 15%; processed size: 8248098816 processing speed: 87933760 bottleneck stats: 81/65/0/40
[13.01.2019 05:01:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 7.7 GB at 95.2 MB/s (15%).
[13.01.2019 05:01:46] <140460756543232> lpbcore| Session progress: 22%; processed size: 12006195200 processing speed: 121738288 bottleneck stats: 77/72/0/72
[13.01.2019 05:01:46] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 11.2 GB at 130.9 MB/s (22%).
[13.01.2019 05:01:51] <140460756543232> lpbcore| Session progress: 29%; processed size: 15764291584 processing speed: 152425394 bottleneck stats: 73/82/0/72
[13.01.2019 05:01:51] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 14.7 GB at 163 MB/s (29%).
[13.01.2019 05:01:56] <140460756543232> lpbcore| Session progress: 36%; processed size: 19522387968 processing speed: 180420386 bottleneck stats: 70/91/0/72
[13.01.2019 05:01:56] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 18.2 GB at 191.9 MB/s (36%).
[13.01.2019 05:02:01] <140460756543232> lpbcore| Session progress: 43%; processed size: 23280484352 processing speed: 206036572 bottleneck stats: 67/100/0/72
[13.01.2019 05:02:01] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 21.7 GB at 218 MB/s (43%).
[13.01.2019 05:02:07] <140460756543232> lpbcore| Session progress: 50%; processed size: 27038580736 processing speed: 227232149 bottleneck stats: 64/100/0/100
[13.01.2019 05:02:07] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 25.2 GB at 239.2 MB/s (50%).
[13.01.2019 05:02:12] <140460756543232> lpbcore| Session progress: 57%; processed size: 30796677120 processing speed: 248807752 bottleneck stats: 61/100/0/100
[13.01.2019 05:02:12] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 28.7 GB at 260.8 MB/s (57%).
[13.01.2019 05:02:16] <140460756543232> lpbcore| Session progress: 64%; processed size: 34554773504 processing speed: 268837611 bottleneck stats: 59/100/0/100
[13.01.2019 05:02:16] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 32.2 GB at 280.8 MB/s (64%).
[13.01.2019 05:02:21] <140460756543232> lpbcore| Session progress: 71%; processed size: 38312869888 processing speed: 287386039 bottleneck stats: 57/100/0/100
[13.01.2019 05:02:21] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 35.7 GB at 299.1 MB/s (71%).
[13.01.2019 05:02:26] <140460756543232> lpbcore| Session progress: 78%; processed size: 42070966272 processing speed: 304451726 bottleneck stats: 55/100/0/100
[13.01.2019 05:02:26] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 39.2 GB at 315.9 MB/s (78%).
[13.01.2019 05:02:31] <140460756543232> lpbcore| Session progress: 85%; processed size: 45829062656 processing speed: 320612994 bottleneck stats: 53/100/0/100
[13.01.2019 05:02:31] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 42.7 GB at 331.7 MB/s (85%).
[13.01.2019 05:02:35] <140460756543232> lpbcore| Session progress: 92%; processed size: 49587159040 processing speed: 335667542 bottleneck stats: 52/100/0/100
[13.01.2019 05:02:35] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 46.2 GB at 346.3 MB/s (92%).
[13.01.2019 05:02:40] <140460756543232> lpbcore| Session progress: 99%; processed size: 53029634048 processing speed: 347897277 bottleneck stats: 50/100/0/100
[13.01.2019 05:02:40] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.4 GB at 358 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53077868544 processing speed: 344411003 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.4 GB at 354.1 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53082062848 processing speed: 344355544 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.4 GB at 354.1 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53086257152 processing speed: 344306811 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.4 GB at 354 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53090451456 processing speed: 344251403 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.4 GB at 353.9 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53092548608 processing speed: 344227057 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.4 GB at 353.9 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53096742912 processing speed: 344189535 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.5 GB at 353.9 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53100937216 processing speed: 344163181 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.5 GB at 353.8 MB/s (99%).
[13.01.2019 05:02:42] <140460756543232> lpbcore| Session progress: 99%; processed size: 53105131520 processing speed: 344145755 bottleneck stats: 51/100/0/100
[13.01.2019 05:02:42] <140460756543232> vmb    | [SessionLog][processing] Backing up sda 49.5 GB at 353.8 MB/s (99%).
/var/log/veeam/Backup/BackupJob/Session_20190113_050001_\{8ad64c4a-ccf8-4664-a1d2-51e90b927548\}/Agent.Source.log

Code: Select all

[13.01.2019 05:00:19] <140479421200128> vsnap  |         Total changes size: accounted [211550208], unaccounted [471859200] bytes.
[13.01.2019 05:00:19] <140479421200128> dsk    |     [emulation] Initializing CBT data ok.
[13.01.2019 05:00:19] <140479421200128> dsk    |     [emulation] Initializing block tracker
[13.01.2019 05:00:19] <140479421200128> dsk    |     [emulation] Initializing block tracker ok.
[13.01.2019 05:00:19] <140479421200128> dsk    |     Swap filter is disabled.
[13.01.2019 05:00:19] <140479421200128> dt     |   Notification sent: changed data size is '53514076160' bytes.
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing CBT data
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] CBT data is already initialized
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing block tracker
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing block tracker ok.
[13.01.2019 05:00:19] <140479421200128> dsk    |   Swap filter is disabled.
[13.01.2019 05:00:19] <140479421200128> dsk    |   Creating disk reader with random access ( processing block size: '1048576').
[13.01.2019 05:00:19] <140479421200128> dt     |   Transmission specification:
[13.01.2019 05:00:19] <140479421200128> dt     |     Block size: [1048576].
[13.01.2019 05:00:19] <140479421200128> dt     |     Is source compressed: [false].
[13.01.2019 05:00:19] <140479421200128> dt     |     Is incremental CTK available: [true].
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing defined block mask.
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing defined block mask. ok.
[13.01.2019 05:00:19] <140479421200128> dt     |   Defined blocks mask is available for the disk.
[13.01.2019 05:00:21] <140479421200128> dt     |   Received upload configuration spec.
[13.01.2019 05:00:21] <140479421200128> dt     |   Transmitter tokens count: [24].
[13.01.2019 05:00:21] <140479421200128> dt     |   Negotiating encryption config. Source: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''.
[13.01.2019 05:00:21] <140479421200128> dt     |     Target: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''.
[13.01.2019 05:00:21] <140479421200128> dt     |   Negotiating encryption config. Source: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''. ok.
[13.01.2019 05:00:21] <140479421200128> alg    |   Using simple sender manager
[13.01.2019 05:00:21] <140479421200128> alg    |   Filter digests are available. Filtering read device will be created.
[13.01.2019 05:00:21] <140479907747584> cli    | Thread started. Thread id: 140479907747584, parent id: 140479421200128, role: area reader : BLOCKS_READER: DISK=Disk Emulator, CTK=Incremental multi-tracker { bitmap_tracker:// , bitmap_tracker:// ,  }
[13.01.2019 05:00:21] <140478901114624> cli    | Thread started. Thread id: 140478901114624, parent id: 140479421200128, role: Area processing dispatcher: Digests calculator.
[13.01.2019 05:00:21] <140478884329216> cli    | Thread started. Thread id: 140478884329216, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478867543808> cli    | Thread started. Thread id: 140478867543808, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140479421200128> alg    |   Transmission pipe configuration, CPU number: 2, digests calc: enabled, compression level: Lz4, crypto policy: Policy: 'enNoCryptoProcessing', target keyset ID: 'null', compression: enabled.
[13.01.2019 05:00:21] <140478842365696> cli    | Thread started. Thread id: 140478842365696, parent id: 140479421200128, role: Area writer: File blocks transmission channel (sender).
[13.01.2019 05:00:21] <140478859151104> cli    | Thread started. Thread id: 140478859151104, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478875936512> cli    | Thread started. Thread id: 140478875936512, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478850758400> cli    | Thread started. Thread id: 140478850758400, parent id: 140479421200128, role: Area processing dispatcher: Data compressor: [Lz4].
[13.01.2019 05:00:21] <140478892721920> cli    | Thread started. Thread id: 140478892721920, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478909507328> cli    | Thread started. Thread id: 140478909507328, parent id: 140479421200128, role: Processing thread: Digests calculator.
[13.01.2019 05:00:21] <140478917900032> cli    | Thread started. Thread id: 140478917900032, parent id: 140479421200128, role: Processing thread: Digests calculator.
[13.01.2019 05:00:21] <140479001761536> cli    | Thread started. Thread id: 140479001761536, parent id: 140479421200128, role: Processing thread: Digests calculator.
[13.01.2019 05:00:21] <140479421200128> cli    |     - 0%, workload src: 98/11/80, ntf: 0/0/0
[13.01.2019 05:00:26] <140479421200128> cli    |     - 1%, workload src: 89/14/0, ntf: 0/11/0
[13.01.2019 05:00:27] <140479421200128> cli    |     - 2%, workload src: 89/14/0, ntf: 89/14/0
[13.01.2019 05:00:27] <140479421200128> cli    |     - 3%, workload src: 89/14/0, ntf: 89/14/0
[13.01.2019 05:00:27] <140479421200128> cli    |     - 4%, workload src: 89/14/0, ntf: 89/14/0
[13.01.2019 05:00:35] <140479421200128> cli    |     - 5%, workload src: 89/17/0, ntf: 89/14/0
[13.01.2019 05:00:36] <140479421200128> cli    |     - 6%, workload src: 89/19/0, ntf: 89/17/0
[13.01.2019 05:00:36] <140479421200128> cli    |     - 7%, workload src: 89/19/0, ntf: 89/17/0
[13.01.2019 05:00:36] <140479421200128> cli    |     - 8%, workload src: 89/19/0, ntf: 89/17/0
[13.01.2019 05:00:43] <140479421200128> cli    |     - 9%, workload src: 89/22/0, ntf: 89/19/0
[13.01.2019 05:00:44] <140479421200128> cli    |     - 10%, workload src: 89/22/0, ntf: 89/22/0
[13.01.2019 05:00:48] <140479421200128> cli    |     - 11%, workload src: 89/24/0, ntf: 89/22/0
[13.01.2019 05:00:55] <140479421200128> cli    |     - 12%, workload src: 89/26/0, ntf: 89/24/0
[13.01.2019 05:01:03] <140479421200128> cli    |     - 13%, workload src: 89/34/0, ntf: 89/26/0
[13.01.2019 05:01:10] <140479421200128> cli    |     - 14%, workload src: 89/35/0, ntf: 89/34/0
[13.01.2019 05:01:12] <140479421200128> cli    |     - 15%, workload src: 89/36/0, ntf: 89/35/0
[13.01.2019 05:01:16] <140479421200128> cli    |     - 16%, workload src: 89/37/0, ntf: 89/36/0
[13.01.2019 05:01:17] <140479421200128> cli    |     - 17%, workload src: 89/37/0, ntf: 89/37/0
[13.01.2019 05:01:21] <140479421200128> cli    |     - 18%, workload src: 89/38/0, ntf: 89/37/0
[13.01.2019 05:01:21] <140479421200128> cli    |     - 19%, workload src: 89/38/0, ntf: 89/37/0
[13.01.2019 05:01:24] <140479421200128> cli    |     - 20%, workload src: 89/38/0, ntf: 89/38/0
[13.01.2019 05:01:27] <140479421200128> cli    |     - 21%, workload src: 89/39/0, ntf: 89/38/0
[13.01.2019 05:01:32] <140479421200128> cli    |     - 22%, workload src: 89/40/0, ntf: 89/39/0
[13.01.2019 05:01:32] <140479421200128> cli    |     - 23%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:33] <140479421200128> cli    |     - 24%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:33] <140479421200128> cli    |     - 25%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:33] <140479421200128> cli    |     - 26%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:37] <140479421200128> cli    |     - 27%, workload src: 86/53/0, ntf: 89/40/0
[13.01.2019 05:01:42] <140479421200128> cli    |     - 28%, workload src: 81/65/0, ntf: 89/40/0
[13.01.2019 05:01:46] <140479421200128> cli    |     - 29%, workload src: 77/72/0, ntf: 89/72/0
[13.01.2019 05:01:51] <140479421200128> cli    |     - 30%, workload src: 73/82/0, ntf: 89/72/0
[13.01.2019 05:01:56] <140479421200128> cli    |     - 31%, workload src: 70/91/0, ntf: 89/72/0
[13.01.2019 05:02:01] <140479421200128> cli    |     - 32%, workload src: 67/100/0, ntf: 89/72/0
[13.01.2019 05:02:07] <140479421200128> cli    |     - 33%, workload src: 64/100/0, ntf: 89/100/0
[13.01.2019 05:02:12] <140479421200128> cli    |     - 34%, workload src: 61/100/0, ntf: 89/100/0
[13.01.2019 05:02:16] <140479421200128> cli    |     - 35%, workload src: 59/100/0, ntf: 89/100/0
[13.01.2019 05:02:21] <140479421200128> cli    |     - 36%, workload src: 57/100/0, ntf: 89/100/0
[13.01.2019 05:02:26] <140479421200128> cli    |     - 37%, workload src: 55/100/0, ntf: 89/100/0
[13.01.2019 05:02:31] <140479421200128> cli    |     - 38%, workload src: 53/100/0, ntf: 89/100/0
[13.01.2019 05:02:35] <140479421200128> cli    |     - 39%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:40] <140479421200128> cli    |     - 40%, workload src: 50/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 41%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 42%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 43%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 44%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 45%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 46%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 47%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 48%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 49%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 50%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:44] <140479421200128> cli    |     - 51%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:44] <140479421200128> cli    |     - 52%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:44] <140479421200128> cli    |     - 53%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 54%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 55%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 56%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 57%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 58%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 59%, workload src: 52/100/0, ntf: 89/100/0
/var/log/veeam/Backup/BackupJob/Session_20190113_050001_\{8ad64c4a-ccf8-4664-a1d2-51e90b927548\}/Agent.Target.log

Code: Select all

[13.01.2019 05:00:19] <140479421200128> vsnap  |         Total changes size: accounted [211550208], unaccounted [471859200] bytes.
[13.01.2019 05:00:19] <140479421200128> dsk    |     [emulation] Initializing CBT data ok.
[13.01.2019 05:00:19] <140479421200128> dsk    |     [emulation] Initializing block tracker
[13.01.2019 05:00:19] <140479421200128> dsk    |     [emulation] Initializing block tracker ok.
[13.01.2019 05:00:19] <140479421200128> dsk    |     Swap filter is disabled.
[13.01.2019 05:00:19] <140479421200128> dt     |   Notification sent: changed data size is '53514076160' bytes.
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing CBT data
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] CBT data is already initialized
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing block tracker
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing block tracker ok.
[13.01.2019 05:00:19] <140479421200128> dsk    |   Swap filter is disabled.
[13.01.2019 05:00:19] <140479421200128> dsk    |   Creating disk reader with random access ( processing block size: '1048576').
[13.01.2019 05:00:19] <140479421200128> dt     |   Transmission specification:
[13.01.2019 05:00:19] <140479421200128> dt     |     Block size: [1048576].
[13.01.2019 05:00:19] <140479421200128> dt     |     Is source compressed: [false].
[13.01.2019 05:00:19] <140479421200128> dt     |     Is incremental CTK available: [true].
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing defined block mask.
[13.01.2019 05:00:19] <140479421200128> dsk    |   [emulation] Initializing defined block mask. ok.
[13.01.2019 05:00:19] <140479421200128> dt     |   Defined blocks mask is available for the disk.
[13.01.2019 05:00:21] <140479421200128> dt     |   Received upload configuration spec.
[13.01.2019 05:00:21] <140479421200128> dt     |   Transmitter tokens count: [24].
[13.01.2019 05:00:21] <140479421200128> dt     |   Negotiating encryption config. Source: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''.
[13.01.2019 05:00:21] <140479421200128> dt     |     Target: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''.
[13.01.2019 05:00:21] <140479421200128> dt     |   Negotiating encryption config. Source: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''. ok.
[13.01.2019 05:00:21] <140479421200128> alg    |   Using simple sender manager
[13.01.2019 05:00:21] <140479421200128> alg    |   Filter digests are available. Filtering read device will be created.
[13.01.2019 05:00:21] <140479907747584> cli    | Thread started. Thread id: 140479907747584, parent id: 140479421200128, role: area reader : BLOCKS_READER: DISK=Disk Emulator, CTK=Incremental multi-tracker { bitmap_tracker:// , bitmap_tracker:// ,  }
[13.01.2019 05:00:21] <140478901114624> cli    | Thread started. Thread id: 140478901114624, parent id: 140479421200128, role: Area processing dispatcher: Digests calculator.
[13.01.2019 05:00:21] <140478884329216> cli    | Thread started. Thread id: 140478884329216, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478867543808> cli    | Thread started. Thread id: 140478867543808, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140479421200128> alg    |   Transmission pipe configuration, CPU number: 2, digests calc: enabled, compression level: Lz4, crypto policy: Policy: 'enNoCryptoProcessing', target keyset ID: 'null', compression: enabled.
[13.01.2019 05:00:21] <140478842365696> cli    | Thread started. Thread id: 140478842365696, parent id: 140479421200128, role: Area writer: File blocks transmission channel (sender).
[13.01.2019 05:00:21] <140478859151104> cli    | Thread started. Thread id: 140478859151104, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478875936512> cli    | Thread started. Thread id: 140478875936512, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478850758400> cli    | Thread started. Thread id: 140478850758400, parent id: 140479421200128, role: Area processing dispatcher: Data compressor: [Lz4].
[13.01.2019 05:00:21] <140478892721920> cli    | Thread started. Thread id: 140478892721920, parent id: 140479421200128, role: Processing thread: Compression transformator.
[13.01.2019 05:00:21] <140478909507328> cli    | Thread started. Thread id: 140478909507328, parent id: 140479421200128, role: Processing thread: Digests calculator.
[13.01.2019 05:00:21] <140478917900032> cli    | Thread started. Thread id: 140478917900032, parent id: 140479421200128, role: Processing thread: Digests calculator.
[13.01.2019 05:00:21] <140479001761536> cli    | Thread started. Thread id: 140479001761536, parent id: 140479421200128, role: Processing thread: Digests calculator.
[13.01.2019 05:00:21] <140479421200128> cli    |     - 0%, workload src: 98/11/80, ntf: 0/0/0
[13.01.2019 05:00:26] <140479421200128> cli    |     - 1%, workload src: 89/14/0, ntf: 0/11/0
[13.01.2019 05:00:27] <140479421200128> cli    |     - 2%, workload src: 89/14/0, ntf: 89/14/0
[13.01.2019 05:00:27] <140479421200128> cli    |     - 3%, workload src: 89/14/0, ntf: 89/14/0
[13.01.2019 05:00:27] <140479421200128> cli    |     - 4%, workload src: 89/14/0, ntf: 89/14/0
[13.01.2019 05:00:35] <140479421200128> cli    |     - 5%, workload src: 89/17/0, ntf: 89/14/0
[13.01.2019 05:00:36] <140479421200128> cli    |     - 6%, workload src: 89/19/0, ntf: 89/17/0
[13.01.2019 05:00:36] <140479421200128> cli    |     - 7%, workload src: 89/19/0, ntf: 89/17/0
[13.01.2019 05:00:36] <140479421200128> cli    |     - 8%, workload src: 89/19/0, ntf: 89/17/0
[13.01.2019 05:00:43] <140479421200128> cli    |     - 9%, workload src: 89/22/0, ntf: 89/19/0
[13.01.2019 05:00:44] <140479421200128> cli    |     - 10%, workload src: 89/22/0, ntf: 89/22/0
[13.01.2019 05:00:48] <140479421200128> cli    |     - 11%, workload src: 89/24/0, ntf: 89/22/0
[13.01.2019 05:00:55] <140479421200128> cli    |     - 12%, workload src: 89/26/0, ntf: 89/24/0
[13.01.2019 05:01:03] <140479421200128> cli    |     - 13%, workload src: 89/34/0, ntf: 89/26/0
[13.01.2019 05:01:10] <140479421200128> cli    |     - 14%, workload src: 89/35/0, ntf: 89/34/0
[13.01.2019 05:01:12] <140479421200128> cli    |     - 15%, workload src: 89/36/0, ntf: 89/35/0
[13.01.2019 05:01:16] <140479421200128> cli    |     - 16%, workload src: 89/37/0, ntf: 89/36/0
[13.01.2019 05:01:17] <140479421200128> cli    |     - 17%, workload src: 89/37/0, ntf: 89/37/0
[13.01.2019 05:01:21] <140479421200128> cli    |     - 18%, workload src: 89/38/0, ntf: 89/37/0
[13.01.2019 05:01:21] <140479421200128> cli    |     - 19%, workload src: 89/38/0, ntf: 89/37/0
[13.01.2019 05:01:24] <140479421200128> cli    |     - 20%, workload src: 89/38/0, ntf: 89/38/0
[13.01.2019 05:01:27] <140479421200128> cli    |     - 21%, workload src: 89/39/0, ntf: 89/38/0
[13.01.2019 05:01:32] <140479421200128> cli    |     - 22%, workload src: 89/40/0, ntf: 89/39/0
[13.01.2019 05:01:32] <140479421200128> cli    |     - 23%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:33] <140479421200128> cli    |     - 24%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:33] <140479421200128> cli    |     - 25%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:33] <140479421200128> cli    |     - 26%, workload src: 89/40/0, ntf: 89/40/0
[13.01.2019 05:01:37] <140479421200128> cli    |     - 27%, workload src: 86/53/0, ntf: 89/40/0
[13.01.2019 05:01:42] <140479421200128> cli    |     - 28%, workload src: 81/65/0, ntf: 89/40/0
[13.01.2019 05:01:46] <140479421200128> cli    |     - 29%, workload src: 77/72/0, ntf: 89/72/0
[13.01.2019 05:01:51] <140479421200128> cli    |     - 30%, workload src: 73/82/0, ntf: 89/72/0
[13.01.2019 05:01:56] <140479421200128> cli    |     - 31%, workload src: 70/91/0, ntf: 89/72/0
[13.01.2019 05:02:01] <140479421200128> cli    |     - 32%, workload src: 67/100/0, ntf: 89/72/0
[13.01.2019 05:02:07] <140479421200128> cli    |     - 33%, workload src: 64/100/0, ntf: 89/100/0
[13.01.2019 05:02:12] <140479421200128> cli    |     - 34%, workload src: 61/100/0, ntf: 89/100/0
[13.01.2019 05:02:16] <140479421200128> cli    |     - 35%, workload src: 59/100/0, ntf: 89/100/0
[13.01.2019 05:02:21] <140479421200128> cli    |     - 36%, workload src: 57/100/0, ntf: 89/100/0
[13.01.2019 05:02:26] <140479421200128> cli    |     - 37%, workload src: 55/100/0, ntf: 89/100/0
[13.01.2019 05:02:31] <140479421200128> cli    |     - 38%, workload src: 53/100/0, ntf: 89/100/0
[13.01.2019 05:02:35] <140479421200128> cli    |     - 39%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:40] <140479421200128> cli    |     - 40%, workload src: 50/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 41%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 42%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 43%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 44%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 45%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 46%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 47%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 48%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 49%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:42] <140479421200128> cli    |     - 50%, workload src: 51/100/0, ntf: 89/100/0
[13.01.2019 05:02:44] <140479421200128> cli    |     - 51%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:44] <140479421200128> cli    |     - 52%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:44] <140479421200128> cli    |     - 53%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 54%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 55%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 56%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 57%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 58%, workload src: 52/100/0, ntf: 89/100/0
[13.01.2019 05:02:45] <140479421200128> cli    |     - 59%, workload src: 52/100/0, ntf: 89/100/0
root@edx:/edx/app/edxapp# tail -n 100 /var/log/veeam/Backup/BackupJob/Session_20190113_050001_\{8ad64c4a-ccf8-4664-a1d2-51e90b927548\}/
Agent.Repair.log  Agent.Source.log  Agent.Target.log  Job.log
root@edx:/edx/app/edxapp# tail -n 100 /var/log/veeam/Backup/BackupJob/Session_20190113_050001_\{8ad64c4a-ccf8-4664-a1d2-51e90b927548\}/Agent.Target.log
[13.01.2019 05:00:21] <140304233527040> stg    |   Metadata for the new increment [{bf3db768-a6f5-4672-861e-423a28a88763}] is created.
[13.01.2019 05:00:21] <140304233527040> stg    |   Periodic flush controller initialized. Controller setting: [Disabled].
[13.01.2019 05:00:21] <140304233527040> stg    | Increment constructed.
[13.01.2019 05:00:21] <140304233527040> stg    | MTA FIB record handle is created, handle '0x000x7f9b18001130', recorder '0x000x7f9b1a9bc230'.
[13.01.2019 05:00:21] <140303688263424> stg    |       Committing metadata.
[13.01.2019 05:00:21] <140303688263424> stg    |         Removing lock on file [/tmp/veeam/10.136.2.34cnotbk/edx BackupJob/BackupJob_2019-01-13T050007.vib].
[13.01.2019 05:00:21] <140303688263424> stg    |         Applying exclusive lock on file [/tmp/veeam/10.136.2.34cnotbk/edx BackupJob/BackupJob_2019-01-13T050007.vib].
[13.01.2019 05:00:21] <140303688263424> stg    |         Metadata snapshot was saved. [1] banks were written to disk.
[13.01.2019 05:00:21] <140303688263424> stg    |         Removing lock on file [/tmp/veeam/10.136.2.34cnotbk/edx BackupJob/BackupJob_2019-01-13T050007.vib].
[13.01.2019 05:00:21] <140303688263424> stg    |         Applying exclusive lock on file [/tmp/veeam/10.136.2.34cnotbk/edx BackupJob/BackupJob_2019-01-13T050007.vib].
[13.01.2019 05:00:21] <140303688263424> stg    |         Metadata snapshot was saved. [1] banks were written to disk.
[13.01.2019 05:00:21] <140303688263424> stg    |         Metadata were committed. Reason: [Changes in custom properties of the increment '{bf3db768-a6f5-4672-861e-423a28a88763}'.]. Version: [3]. Storage: [/tmp/veeam/10.136.2.34cnotbk/edx BackupJob/BackupJob_2019-01-13T050007.vib]. Banks number: [3].
[13.01.2019 05:00:21] <140303688263424> stg    |       Committing metadata. ok.
[13.01.2019 05:00:21] <140303688263424> dt     |     Opening backup disk target for disk '{bf3db768-a6f5-4672-861e-423a28a88763}'. ok.
[13.01.2019 05:00:21] <140303688263424> dt     |     Source crypto policy: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''.
[13.01.2019 05:00:21] <140303688263424> dt     |     Source requested traffic compression level: [Lz4].
[13.01.2019 05:00:21] <140303688263424> dt     |     Preparing transmission configuration spec.
[13.01.2019 05:00:21] <140303688263424> dt     |       Traffic compression enabled: [Lz4].
[13.01.2019 05:00:21] <140303688263424> dt     |       Target blocks repacking is not required, target and traffic compression are equal.
[13.01.2019 05:00:21] <140303688263424> dt     |       Digests were extracted from target.
[13.01.2019 05:00:21] <140303688263424> dt     |       Digests calculation and filtering should be done at upload side.
[13.01.2019 05:00:21] <140303688263424> dt     |       Creating recommended transport configuration using pool id [2].
[13.01.2019 05:00:21] <140303688263424> dt     |       Negotiating encryption config. Target: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''.
[13.01.2019 05:00:21] <140303688263424> dt     |       Negotiating encryption config. Target: 'Policy: 'enNoCryptoProcessing', target keyset ID: 'null''. ok.
[13.01.2019 05:00:21] <140303688263424> dt     |       Multi-streaming is disabled.
[13.01.2019 05:00:21] <140303688263424> dt     |       Receiver tokens count: [8].
[13.01.2019 05:00:21] <140303688263424> dt     |     Preparing transmission configuration spec. ok.
[13.01.2019 05:00:21] <140303688263424> alg    |     Using simple receiver manager
[13.01.2019 05:00:21] <140303394649856> cli    | Thread started. Thread id: 140303394649856, parent id: 140303688263424, role: area reader : Receiver channel for {bf3db768-a6f5-4672-861e-423a28a88763}
[13.01.2019 05:00:21] <140303688263424> alg    |     Transmission pipe configuration, CPU number: 2, crypto policy: Policy: 'enNoCryptoProcessing', target keyset ID: 'null'
[13.01.2019 05:00:21] <140303428220672> cli    | Thread started. Thread id: 140303428220672, parent id: 140303688263424, role: Area writer: Traditional incremental backup of the FIB Increment {bf3db768-a6f5-4672-861e-423a28a88763}.
[13.01.2019 05:00:21] <140303688263424> cli    |       - 0%, workload rps: 0/11/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:26] <140303688263424> cli    |       - 1%, workload rps: 89/14/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:27] <140303688263424> cli    |       - 2%, workload rps: 89/14/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:27] <140303688263424> cli    |       - 3%, workload rps: 89/14/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:27] <140303688263424> cli    |       - 4%, workload rps: 89/14/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:35] <140303688263424> cli    |       - 5%, workload rps: 89/17/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:37] <140303688263424> cli    |       - 6%, workload rps: 89/19/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:37] <140303688263424> cli    |       - 7%, workload rps: 89/19/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:37] <140303688263424> cli    |       - 8%, workload rps: 89/19/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:43] <140303688263424> cli    |       - 9%, workload rps: 89/22/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:44] <140303688263424> cli    |       - 10%, workload rps: 89/22/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:49] <140303688263424> cli    |       - 11%, workload rps: 89/24/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:00:55] <140303688263424> cli    |       - 12%, workload rps: 89/26/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:03] <140303688263424> cli    |       - 13%, workload rps: 89/34/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:10] <140303688263424> cli    |       - 14%, workload rps: 89/35/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:12] <140303688263424> cli    |       - 15%, workload rps: 89/36/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:16] <140303688263424> cli    |       - 16%, workload rps: 89/37/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:17] <140303688263424> cli    |       - 17%, workload rps: 89/37/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:21] <140303688263424> cli    |       - 18%, workload rps: 89/38/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:21] <140303688263424> cli    |       - 19%, workload rps: 89/38/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:25] <140303688263424> cli    |       - 20%, workload rps: 89/38/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:28] <140303688263424> cli    |       - 21%, workload rps: 89/39/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:32] <140303688263424> cli    |       - 22%, workload rps: 89/40/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:33] <140303688263424> cli    |       - 23%, workload rps: 89/40/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:33] <140303688263424> cli    |       - 24%, workload rps: 89/40/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:45] <140303688263424> cli    |       - 24%, workload rps: 89/65/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:46] <140303688263424> cli    |       - 25%, workload rps: 89/72/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:46] <140303688263424> cli    |       - 26%, workload rps: 89/72/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:46] <140303688263424> cli    |       - 27%, workload rps: 89/72/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:01:46] <140303688263424> cli    |       - 28%, workload rps: 89/72/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:04] <140303688263424> cli    |       - 28%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:06] <140303688263424> cli    |       - 29%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:06] <140303688263424> cli    |       - 30%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:06] <140303688263424> cli    |       - 31%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:06] <140303688263424> cli    |       - 32%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:22] <140303688263424> cli    |       - 32%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:23] <140303688263424> cli    |       - 33%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:23] <140303688263424> cli    |       - 34%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:23] <140303688263424> cli    |       - 35%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:23] <140303688263424> cli    |       - 36%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:39] <140303688263424> cli    |       - 36%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:41] <140303688263424> cli    |       - 37%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:41] <140303688263424> cli    |       - 38%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:41] <140303688263424> cli    |       - 39%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:41] <140303688263424> cli    |       - 40%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 41%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 42%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 43%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 44%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 45%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 46%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 47%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 48%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 49%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:42] <140303688263424> cli    |       - 50%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 51%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 52%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 53%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 54%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 55%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 56%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 57%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 58%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 59%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 60%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 61%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 62%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    |       - 63%, workload rps: 89/100/0, client: {8b9f2796-c562-4cae-9fec-f0ce4a51b291}
[13.01.2019 05:02:46] <140303688263424> cli    

vmniels
Veeam Software
Posts: 2131
Liked: 472 times
Joined: Jul 15, 2013 11:09 am
Full Name: Niels Engelen
Contact:

Re: Failed auto recover job. Server overload

Post by vmniels » Jan 14, 2019 12:08 pm

Hi Ekaterina, please contact support with the insight of the logs so they can assist you further. Pasting logs sadly won't be enough to resolve this issue as they don't identify what went wrong so it can be multiple things. If possible post the case ID for future references. Thanks.
VCP-DCV
Veeam Certified Architect (VMCA)
http://foonet.be

Post Reply

Who is online

Users browsing this forum: No registered users and 2 guests