Продолжение /var/log/messages в день успешного бэкапа
Sep 28 22:07:17 xs-venus ovs-vswitchd: 19405|timeval|WARN|761 ms poll interval (0 ms user, 0 ms system) is over 1217 times the weighted mean interval 1 ms (31434327 samples)
Sep 28 22:07:17 xs-venus ovs-vswitchd: 19406|timeval|WARN|context switches: 222 voluntary, 0 involuntary
Sep 28 22:07:17 xs-venus ovs-vswitchd: 19407|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31434327
Sep 28 22:07:23 xs-venus ovs-vswitchd: 19408|timeval|WARN|325 ms poll interval (0 ms user, 10 ms system) is over 32 times the weighted mean interval 10 ms (31434355 samples)
Sep 28 22:07:23 xs-venus ovs-vswitchd: 19409|timeval|WARN|context switches: 206 voluntary, 0 involuntary
Sep 28 22:07:23 xs-venus ovs-vswitchd: 19410|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31434355
Sep 28 22:08:23 xs-venus ovs-vswitchd: 19411|timeval|WARN|12 ms poll interval (0 ms user, 0 ms system) is over 19 times the weighted mean interval 1 ms (31434833 samples)
Sep 28 22:08:23 xs-venus ovs-vswitchd: 19412|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:08:23 xs-venus ovs-vswitchd: 19413|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31434833
Sep 28 22:08:58 xs-venus ovs-vswitchd: 19414|timeval|WARN|12 ms poll interval (0 ms user, 0 ms system) is over 19 times the weighted mean interval 1 ms (31435055 samples)
Sep 28 22:08:58 xs-venus ovs-vswitchd: 19415|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:08:58 xs-venus ovs-vswitchd: 19416|coverage|INFO|Skipping details of duplicate event coverage for hash=84e90a37 in epoch 31435055
Sep 28 22:10:33 xs-venus ovs-vswitchd: 19417|timeval|WARN|180 ms poll interval (0 ms user, 0 ms system) is over 288 times the weighted mean interval 1 ms (31435673 samples)
Sep 28 22:10:33 xs-venus ovs-vswitchd: 19418|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:10:33 xs-venus ovs-vswitchd: 19419|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31435673
Sep 28 22:11:14 xs-venus ovs-vswitchd: 19420|timeval|WARN|497 ms poll interval (0 ms user, 10 ms system) is over 795 times the weighted mean interval 1 ms (31435937 samples)
Sep 28 22:11:14 xs-venus ovs-vswitchd: 19421|timeval|WARN|context switches: 291 voluntary, 0 involuntary
Sep 28 22:11:14 xs-venus ovs-vswitchd: 19422|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31435937
Sep 28 22:11:39 xs-venus ovs-vswitchd: 19423|timeval|WARN|338 ms poll interval (0 ms user, 10 ms system) is over 540 times the weighted mean interval 1 ms (31436068 samples)
Sep 28 22:11:39 xs-venus ovs-vswitchd: 19424|timeval|WARN|context switches: 349 voluntary, 0 involuntary
Sep 28 22:11:39 xs-venus ovs-vswitchd: 19425|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31436068
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19426|timeval|WARN|15 ms poll interval (0 ms user, 0 ms system) is over 24 times the weighted mean interval 1 ms (31436293 samples)
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19427|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19428|timeval|WARN|context switches: 2 voluntary, 0 involuntary
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19429|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31436293
Sep 28 22:12:14 xs-venus ovsdb-server: 08011|timeval|WARN|317 ms poll interval (0 ms user, 0 ms system) is over 507 times the weighted mean interval 1 ms (2509870 samples)
Sep 28 22:12:14 xs-venus ovsdb-server: 08012|timeval|WARN|context switches: 53 voluntary, 0 involuntary
Sep 28 22:12:14 xs-venus ovsdb-server: 08013|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2509870
Sep 28 22:12:24 xs-venus ovs-vswitchd: 19430|timeval|WARN|281 ms poll interval (0 ms user, 10 ms system) is over 449 times the weighted mean interval 1 ms (31436377 samples)
Sep 28 22:12:24 xs-venus ovs-vswitchd: 19431|timeval|WARN|context switches: 101 voluntary, 0 involuntary
Sep 28 22:12:24 xs-venus ovs-vswitchd: 19432|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31436377
Sep 28 22:13:27 xs-venus ovsdb-server: 08014|timeval|WARN|2141 ms poll interval (0 ms user, 10 ms system) is over 1557 times the weighted mean interval 1 ms (2509930 samples)
Sep 28 22:13:27 xs-venus ovsdb-server: 08015|timeval|WARN|context switches: 677 voluntary, 0 involuntary
Sep 28 22:13:27 xs-venus ovsdb-server: 08016|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2509930
Sep 28 22:14:15 xs-venus ovs-vswitchd: 19433|timeval|WARN|880 ms poll interval (0 ms user, 10 ms system) is over 1408 times the weighted mean interval 1 ms (31437069 samples)
Sep 28 22:14:15 xs-venus ovs-vswitchd: 19434|timeval|WARN|context switches: 485 voluntary, 0 involuntary
Sep 28 22:14:15 xs-venus ovs-vswitchd: 19435|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31437069
Sep 28 22:14:21 xs-venus ovsdb-server: 08017|timeval|WARN|349 ms poll interval (0 ms user, 10 ms system) is over 28 times the weighted mean interval 12 ms (2509976 samples)
Sep 28 22:14:21 xs-venus ovsdb-server: 08018|timeval|WARN|context switches: 72 voluntary, 0 involuntary
Sep 28 22:14:21 xs-venus ovsdb-server: 08019|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2509976
Sep 28 22:14:26 xs-venus ovs-vswitchd: 19436|timeval|WARN|435 ms poll interval (0 ms user, 0 ms system) is over 535 times the weighted mean interval 1 ms (31437160 samples)
Sep 28 22:14:26 xs-venus ovs-vswitchd: 19437|timeval|WARN|context switches: 35 voluntary, 0 involuntary
Sep 28 22:14:26 xs-venus ovs-vswitchd: 19438|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31437160
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19439|timeval|WARN|16 ms poll interval (0 ms user, 0 ms system) is over 17 times the weighted mean interval 1 ms (31437233 samples)
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19440|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19441|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19442|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31437233
Sep 28 22:14:37 xs-venus ovsdb-server: 08020|timeval|WARN|646 ms poll interval (0 ms user, 10 ms system) is over 44 times the weighted mean interval 14 ms (2509991 samples)
Sep 28 22:14:37 xs-venus ovsdb-server: 08021|timeval|WARN|context switches: 560 voluntary, 0 involuntary
Sep 28 22:14:37 xs-venus ovsdb-server: 08022|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2509991
Sep 28 22:15:17 xs-venus ovsdb-server: 08023|timeval|WARN|769 ms poll interval (0 ms user, 0 ms system) is over 71 times the weighted mean interval 11 ms (2510022 samples)
Sep 28 22:15:17 xs-venus ovsdb-server: 08024|timeval|WARN|context switches: 499 voluntary, 0 involuntary
Sep 28 22:15:17 xs-venus ovsdb-server: 08025|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510022
Sep 28 22:15:56 xs-venus ovsdb-server: 08026|timeval|WARN|264 ms poll interval (0 ms user, 0 ms system) is over 25 times the weighted mean interval 10 ms (2510055 samples)
Sep 28 22:15:56 xs-venus ovsdb-server: 08027|timeval|WARN|context switches: 11 voluntary, 0 involuntary
Sep 28 22:15:56 xs-venus ovsdb-server: 08028|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510055
Sep 28 22:16:00 xs-venus fe: qemu-dm-149[5843]: XENUTIL Notice 113(2): BF059000 - BF06FFFF: RDPDD.dll
Sep 28 22:16:00 xs-venus fe: qemu-dm-149[5843]: XENUTIL Notice 113(3): BF059000 - BF06FFFF: RDPDD.dll
Sep 28 22:18:16 xs-venus ovs-vswitchd: 19443|timeval|WARN|60 ms poll interval (0 ms user, 0 ms system) is over 96 times the weighted mean interval 1 ms (31438737 samples)
Sep 28 22:18:16 xs-venus ovs-vswitchd: 19444|timeval|WARN|context switches: 3 voluntary, 0 involuntary
Sep 28 22:18:16 xs-venus ovs-vswitchd: 19445|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31438737
Sep 28 22:18:16 xs-venus ovsdb-server: 08029|timeval|WARN|54 ms poll interval (0 ms user, 0 ms system) is over 86 times the weighted mean interval 1 ms (2510167 samples)
Sep 28 22:18:16 xs-venus ovsdb-server: 08030|timeval|WARN|context switches: 49 voluntary, 0 involuntary
Sep 28 22:18:16 xs-venus ovsdb-server: 08031|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510167
Sep 28 22:18:57 xs-venus ovsdb-server: 08032|timeval|WARN|512 ms poll interval (0 ms user, 0 ms system) is over 390 times the weighted mean interval 1 ms (2510199 samples)
Sep 28 22:18:57 xs-venus ovsdb-server: 08033|timeval|WARN|context switches: 129 voluntary, 0 involuntary
Sep 28 22:18:57 xs-venus ovsdb-server: 08034|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510199
Sep 28 22:19:17 xs-venus ovsdb-server: 08035|timeval|WARN|886 ms poll interval (0 ms user, 10 ms system) is over 61 times the weighted mean interval 14 ms (2510212 samples)
Sep 28 22:19:17 xs-venus ovsdb-server: 08036|timeval|WARN|faults: 1 minor, 1 major
Sep 28 22:19:17 xs-venus ovsdb-server: 08037|timeval|WARN|context switches: 541 voluntary, 0 involuntary
Sep 28 22:19:17 xs-venus ovsdb-server: 08038|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510212
Sep 28 22:19:38 xs-venus ovsdb-server: 08039|timeval|WARN|1075 ms poll interval (0 ms user, 10 ms system) is over 39 times the weighted mean interval 27 ms (2510228 samples)
Sep 28 22:19:38 xs-venus ovsdb-server: 08040|timeval|WARN|context switches: 550 voluntary, 0 involuntary
Sep 28 22:19:38 xs-venus ovsdb-server: 08041|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510228
Sep 28 22:20:27 xs-venus ovs-vswitchd: 19446|timeval|WARN|11 ms poll interval (0 ms user, 0 ms system) is over 17 times the weighted mean interval 1 ms (31439586 samples)
Sep 28 22:20:27 xs-venus ovs-vswitchd: 19447|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:20:27 xs-venus ovs-vswitchd: 19448|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31439586
Sep 28 22:20:27 xs-venus ovsdb-server: 08042|timeval|WARN|554 ms poll interval (0 ms user, 10 ms system) is over 42 times the weighted mean interval 13 ms (2510267 samples)
Sep 28 22:20:27 xs-venus ovsdb-server: 08043|timeval|WARN|context switches: 129 voluntary, 0 involuntary
Sep 28 22:20:27 xs-venus ovsdb-server: 08044|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510267
Sep 28 22:20:47 xs-venus ovsdb-server: 08045|timeval|WARN|158 ms poll interval (0 ms user, 10 ms system) is over 8 times the weighted mean interval 18 ms (2510285 samples)
Sep 28 22:20:47 xs-venus ovsdb-server: 08046|timeval|WARN|context switches: 439 voluntary, 0 involuntary
Sep 28 22:20:47 xs-venus ovsdb-server: 08047|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510285
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19449|timeval|WARN|14 ms poll interval (0 ms user, 10 ms system) is over 22 times the weighted mean interval 1 ms (31439980 samples)
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19450|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19451|timeval|WARN|context switches: 2 voluntary, 0 involuntary
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19452|coverage|INFO|Skipping details of duplicate event coverage for hash=9c3d7749 in epoch 31439980
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19453|timeval|WARN|11 ms poll interval (0 ms user, 10 ms system) is over 17 times the weighted mean interval 1 ms (31440139 samples)
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19454|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19455|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19456|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31440139
Sep 28 22:22:07 xs-venus ovsdb-server: 08048|timeval|WARN|61 ms poll interval (0 ms user, 0 ms system) is over 29 times the weighted mean interval 2 ms (2510348 samples)
Sep 28 22:22:07 xs-venus ovsdb-server: 08049|timeval|WARN|context switches: 15 voluntary, 0 involuntary
Sep 28 22:22:07 xs-venus ovsdb-server: 08050|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510348
Sep 28 22:22:27 xs-venus ovsdb-server: 08051|timeval|WARN|159 ms poll interval (0 ms user, 0 ms system) is over 55 times the weighted mean interval 3 ms (2510362 samples)
Sep 28 22:22:27 xs-venus ovsdb-server: 08052|timeval|WARN|context switches: 28 voluntary, 0 involuntary
Sep 28 22:22:27 xs-venus ovsdb-server: 08053|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510362
Sep 28 22:25:20 xs-venus multipathd: xvda1: remove path (operator)
Sep 28 22:25:20 xs-venus multipathd: xvda1: spurious uevent, path not in pathvec
Sep 28 22:25:20 xs-venus multipathd: xvda: remove path (operator)
Sep 28 22:25:20 xs-venus multipathd: xvda: spurious uevent, path not in pathvec
Sep 28 22:25:21 xs-venus vbd.uevent[remove](backend/vbd/0/51712): removed /xapi/0/hotplug/vbd/51712/hotplug
Sep 28 22:25:21 xs-venus vbd.uevent[remove](backend/vbd/0/51712): removed backend/vbd/0/51712/hotplug-status
Sep 28 22:25:22 xs-venus tapdisk[28778]: gaps written/skipped: 0/0
Sep 28 22:25:22 xs-venus tapdisk[28778]: /dev/VG_XenStorage-44a08f67-f2d7-62c8-90d7-4cb9f66ca887/VHD-72fd3b46-3260-4b62-9a91-6501c6d04678: b: 8192, a: 7966, f: 7962, n: 0
Sep 28 22:25:22 xs-venus tapdisk[28778]: closed image /dev/VG_XenStorage-44a08f67-f2d7-62c8-90d7-4cb9f66ca887/VHD-72fd3b46-3260-4b62-9a91-6501c6d04678 (0 users, state: 0x00000002, type: 4)
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-log: closing after 0 errors
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-syslog: 11 messages, 905 bytes, xmits: 12, failed: 0, dropped: 0
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-control: draining 1 connections
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-control: done Sep 28 22:07:17 xs-venus ovs-vswitchd: 19405|timeval|WARN|761 ms poll interval (0 ms user, 0 ms system) is over 1217 times the weighted mean interval 1 ms (31434327 samples)
Sep 28 22:07:17 xs-venus ovs-vswitchd: 19406|timeval|WARN|context switches: 222 voluntary, 0 involuntary
Sep 28 22:07:17 xs-venus ovs-vswitchd: 19407|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31434327
Sep 28 22:07:23 xs-venus ovs-vswitchd: 19408|timeval|WARN|325 ms poll interval (0 ms user, 10 ms system) is over 32 times the weighted mean interval 10 ms (31434355 samples)
Sep 28 22:07:23 xs-venus ovs-vswitchd: 19409|timeval|WARN|context switches: 206 voluntary, 0 involuntary
Sep 28 22:07:23 xs-venus ovs-vswitchd: 19410|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31434355
Sep 28 22:08:23 xs-venus ovs-vswitchd: 19411|timeval|WARN|12 ms poll interval (0 ms user, 0 ms system) is over 19 times the weighted mean interval 1 ms (31434833 samples)
Sep 28 22:08:23 xs-venus ovs-vswitchd: 19412|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:08:23 xs-venus ovs-vswitchd: 19413|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31434833
Sep 28 22:08:58 xs-venus ovs-vswitchd: 19414|timeval|WARN|12 ms poll interval (0 ms user, 0 ms system) is over 19 times the weighted mean interval 1 ms (31435055 samples)
Sep 28 22:08:58 xs-venus ovs-vswitchd: 19415|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:08:58 xs-venus ovs-vswitchd: 19416|coverage|INFO|Skipping details of duplicate event coverage for hash=84e90a37 in epoch 31435055
Sep 28 22:10:33 xs-venus ovs-vswitchd: 19417|timeval|WARN|180 ms poll interval (0 ms user, 0 ms system) is over 288 times the weighted mean interval 1 ms (31435673 samples)
Sep 28 22:10:33 xs-venus ovs-vswitchd: 19418|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:10:33 xs-venus ovs-vswitchd: 19419|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31435673
Sep 28 22:11:14 xs-venus ovs-vswitchd: 19420|timeval|WARN|497 ms poll interval (0 ms user, 10 ms system) is over 795 times the weighted mean interval 1 ms (31435937 samples)
Sep 28 22:11:14 xs-venus ovs-vswitchd: 19421|timeval|WARN|context switches: 291 voluntary, 0 involuntary
Sep 28 22:11:14 xs-venus ovs-vswitchd: 19422|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31435937
Sep 28 22:11:39 xs-venus ovs-vswitchd: 19423|timeval|WARN|338 ms poll interval (0 ms user, 10 ms system) is over 540 times the weighted mean interval 1 ms (31436068 samples)
Sep 28 22:11:39 xs-venus ovs-vswitchd: 19424|timeval|WARN|context switches: 349 voluntary, 0 involuntary
Sep 28 22:11:39 xs-venus ovs-vswitchd: 19425|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31436068
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19426|timeval|WARN|15 ms poll interval (0 ms user, 0 ms system) is over 24 times the weighted mean interval 1 ms (31436293 samples)
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19427|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19428|timeval|WARN|context switches: 2 voluntary, 0 involuntary
Sep 28 22:12:09 xs-venus ovs-vswitchd: 19429|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31436293
Sep 28 22:12:14 xs-venus ovsdb-server: 08011|timeval|WARN|317 ms poll interval (0 ms user, 0 ms system) is over 507 times the weighted mean interval 1 ms (2509870 samples)
Sep 28 22:12:14 xs-venus ovsdb-server: 08012|timeval|WARN|context switches: 53 voluntary, 0 involuntary
Sep 28 22:12:14 xs-venus ovsdb-server: 08013|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2509870
Sep 28 22:12:24 xs-venus ovs-vswitchd: 19430|timeval|WARN|281 ms poll interval (0 ms user, 10 ms system) is over 449 times the weighted mean interval 1 ms (31436377 samples)
Sep 28 22:12:24 xs-venus ovs-vswitchd: 19431|timeval|WARN|context switches: 101 voluntary, 0 involuntary
Sep 28 22:12:24 xs-venus ovs-vswitchd: 19432|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31436377
Sep 28 22:13:27 xs-venus ovsdb-server: 08014|timeval|WARN|2141 ms poll interval (0 ms user, 10 ms system) is over 1557 times the weighted mean interval 1 ms (2509930 samples)
Sep 28 22:13:27 xs-venus ovsdb-server: 08015|timeval|WARN|context switches: 677 voluntary, 0 involuntary
Sep 28 22:13:27 xs-venus ovsdb-server: 08016|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2509930
Sep 28 22:14:15 xs-venus ovs-vswitchd: 19433|timeval|WARN|880 ms poll interval (0 ms user, 10 ms system) is over 1408 times the weighted mean interval 1 ms (31437069 samples)
Sep 28 22:14:15 xs-venus ovs-vswitchd: 19434|timeval|WARN|context switches: 485 voluntary, 0 involuntary
Sep 28 22:14:15 xs-venus ovs-vswitchd: 19435|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31437069
Sep 28 22:14:21 xs-venus ovsdb-server: 08017|timeval|WARN|349 ms poll interval (0 ms user, 10 ms system) is over 28 times the weighted mean interval 12 ms (2509976 samples)
Sep 28 22:14:21 xs-venus ovsdb-server: 08018|timeval|WARN|context switches: 72 voluntary, 0 involuntary
Sep 28 22:14:21 xs-venus ovsdb-server: 08019|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2509976
Sep 28 22:14:26 xs-venus ovs-vswitchd: 19436|timeval|WARN|435 ms poll interval (0 ms user, 0 ms system) is over 535 times the weighted mean interval 1 ms (31437160 samples)
Sep 28 22:14:26 xs-venus ovs-vswitchd: 19437|timeval|WARN|context switches: 35 voluntary, 0 involuntary
Sep 28 22:14:26 xs-venus ovs-vswitchd: 19438|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31437160
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19439|timeval|WARN|16 ms poll interval (0 ms user, 0 ms system) is over 17 times the weighted mean interval 1 ms (31437233 samples)
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19440|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19441|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:14:36 xs-venus ovs-vswitchd: 19442|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31437233
Sep 28 22:14:37 xs-venus ovsdb-server: 08020|timeval|WARN|646 ms poll interval (0 ms user, 10 ms system) is over 44 times the weighted mean interval 14 ms (2509991 samples)
Sep 28 22:14:37 xs-venus ovsdb-server: 08021|timeval|WARN|context switches: 560 voluntary, 0 involuntary
Sep 28 22:14:37 xs-venus ovsdb-server: 08022|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2509991
Sep 28 22:15:17 xs-venus ovsdb-server: 08023|timeval|WARN|769 ms poll interval (0 ms user, 0 ms system) is over 71 times the weighted mean interval 11 ms (2510022 samples)
Sep 28 22:15:17 xs-venus ovsdb-server: 08024|timeval|WARN|context switches: 499 voluntary, 0 involuntary
Sep 28 22:15:17 xs-venus ovsdb-server: 08025|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510022
Sep 28 22:15:56 xs-venus ovsdb-server: 08026|timeval|WARN|264 ms poll interval (0 ms user, 0 ms system) is over 25 times the weighted mean interval 10 ms (2510055 samples)
Sep 28 22:15:56 xs-venus ovsdb-server: 08027|timeval|WARN|context switches: 11 voluntary, 0 involuntary
Sep 28 22:15:56 xs-venus ovsdb-server: 08028|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510055
Sep 28 22:16:00 xs-venus fe: qemu-dm-149[5843]: XENUTIL Notice 113(2): BF059000 - BF06FFFF: RDPDD.dll
Sep 28 22:16:00 xs-venus fe: qemu-dm-149[5843]: XENUTIL Notice 113(3): BF059000 - BF06FFFF: RDPDD.dll
Sep 28 22:18:16 xs-venus ovs-vswitchd: 19443|timeval|WARN|60 ms poll interval (0 ms user, 0 ms system) is over 96 times the weighted mean interval 1 ms (31438737 samples)
Sep 28 22:18:16 xs-venus ovs-vswitchd: 19444|timeval|WARN|context switches: 3 voluntary, 0 involuntary
Sep 28 22:18:16 xs-venus ovs-vswitchd: 19445|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31438737
Sep 28 22:18:16 xs-venus ovsdb-server: 08029|timeval|WARN|54 ms poll interval (0 ms user, 0 ms system) is over 86 times the weighted mean interval 1 ms (2510167 samples)
Sep 28 22:18:16 xs-venus ovsdb-server: 08030|timeval|WARN|context switches: 49 voluntary, 0 involuntary
Sep 28 22:18:16 xs-venus ovsdb-server: 08031|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510167
Sep 28 22:18:57 xs-venus ovsdb-server: 08032|timeval|WARN|512 ms poll interval (0 ms user, 0 ms system) is over 390 times the weighted mean interval 1 ms (2510199 samples)
Sep 28 22:18:57 xs-venus ovsdb-server: 08033|timeval|WARN|context switches: 129 voluntary, 0 involuntary
Sep 28 22:18:57 xs-venus ovsdb-server: 08034|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510199
Sep 28 22:19:17 xs-venus ovsdb-server: 08035|timeval|WARN|886 ms poll interval (0 ms user, 10 ms system) is over 61 times the weighted mean interval 14 ms (2510212 samples)
Sep 28 22:19:17 xs-venus ovsdb-server: 08036|timeval|WARN|faults: 1 minor, 1 major
Sep 28 22:19:17 xs-venus ovsdb-server: 08037|timeval|WARN|context switches: 541 voluntary, 0 involuntary
Sep 28 22:19:17 xs-venus ovsdb-server: 08038|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510212
Sep 28 22:19:38 xs-venus ovsdb-server: 08039|timeval|WARN|1075 ms poll interval (0 ms user, 10 ms system) is over 39 times the weighted mean interval 27 ms (2510228 samples)
Sep 28 22:19:38 xs-venus ovsdb-server: 08040|timeval|WARN|context switches: 550 voluntary, 0 involuntary
Sep 28 22:19:38 xs-venus ovsdb-server: 08041|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510228
Sep 28 22:20:27 xs-venus ovs-vswitchd: 19446|timeval|WARN|11 ms poll interval (0 ms user, 0 ms system) is over 17 times the weighted mean interval 1 ms (31439586 samples)
Sep 28 22:20:27 xs-venus ovs-vswitchd: 19447|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:20:27 xs-venus ovs-vswitchd: 19448|coverage|INFO|Skipping details of duplicate event coverage for hash=2e98b47a in epoch 31439586
Sep 28 22:20:27 xs-venus ovsdb-server: 08042|timeval|WARN|554 ms poll interval (0 ms user, 10 ms system) is over 42 times the weighted mean interval 13 ms (2510267 samples)
Sep 28 22:20:27 xs-venus ovsdb-server: 08043|timeval|WARN|context switches: 129 voluntary, 0 involuntary
Sep 28 22:20:27 xs-venus ovsdb-server: 08044|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510267
Sep 28 22:20:47 xs-venus ovsdb-server: 08045|timeval|WARN|158 ms poll interval (0 ms user, 10 ms system) is over 8 times the weighted mean interval 18 ms (2510285 samples)
Sep 28 22:20:47 xs-venus ovsdb-server: 08046|timeval|WARN|context switches: 439 voluntary, 0 involuntary
Sep 28 22:20:47 xs-venus ovsdb-server: 08047|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510285
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19449|timeval|WARN|14 ms poll interval (0 ms user, 10 ms system) is over 22 times the weighted mean interval 1 ms (31439980 samples)
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19450|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19451|timeval|WARN|context switches: 2 voluntary, 0 involuntary
Sep 28 22:21:24 xs-venus ovs-vswitchd: 19452|coverage|INFO|Skipping details of duplicate event coverage for hash=9c3d7749 in epoch 31439980
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19453|timeval|WARN|11 ms poll interval (0 ms user, 10 ms system) is over 17 times the weighted mean interval 1 ms (31440139 samples)
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19454|timeval|WARN|faults: 0 minor, 1 major
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19455|timeval|WARN|context switches: 1 voluntary, 0 involuntary
Sep 28 22:21:57 xs-venus ovs-vswitchd: 19456|coverage|INFO|Skipping details of duplicate event coverage for hash=b0e699e3 in epoch 31440139
Sep 28 22:22:07 xs-venus ovsdb-server: 08048|timeval|WARN|61 ms poll interval (0 ms user, 0 ms system) is over 29 times the weighted mean interval 2 ms (2510348 samples)
Sep 28 22:22:07 xs-venus ovsdb-server: 08049|timeval|WARN|context switches: 15 voluntary, 0 involuntary
Sep 28 22:22:07 xs-venus ovsdb-server: 08050|coverage|INFO|Skipping details of duplicate event coverage for hash=253343d5 in epoch 2510348
Sep 28 22:22:27 xs-venus ovsdb-server: 08051|timeval|WARN|159 ms poll interval (0 ms user, 0 ms system) is over 55 times the weighted mean interval 3 ms (2510362 samples)
Sep 28 22:22:27 xs-venus ovsdb-server: 08052|timeval|WARN|context switches: 28 voluntary, 0 involuntary
Sep 28 22:22:27 xs-venus ovsdb-server: 08053|coverage|INFO|Skipping details of duplicate event coverage for hash=abb17da2 in epoch 2510362
Sep 28 22:25:20 xs-venus multipathd: xvda1: remove path (operator)
Sep 28 22:25:20 xs-venus multipathd: xvda1: spurious uevent, path not in pathvec
Sep 28 22:25:20 xs-venus multipathd: xvda: remove path (operator)
Sep 28 22:25:20 xs-venus multipathd: xvda: spurious uevent, path not in pathvec
Sep 28 22:25:21 xs-venus vbd.uevent[remove](backend/vbd/0/51712): removed /xapi/0/hotplug/vbd/51712/hotplug
Sep 28 22:25:21 xs-venus vbd.uevent[remove](backend/vbd/0/51712): removed backend/vbd/0/51712/hotplug-status
Sep 28 22:25:22 xs-venus tapdisk[28778]: gaps written/skipped: 0/0
Sep 28 22:25:22 xs-venus tapdisk[28778]: /dev/VG_XenStorage-44a08f67-f2d7-62c8-90d7-4cb9f66ca887/VHD-72fd3b46-3260-4b62-9a91-6501c6d04678: b: 8192, a: 7966, f: 7962, n: 0
Sep 28 22:25:22 xs-venus tapdisk[28778]: closed image /dev/VG_XenStorage-44a08f67-f2d7-62c8-90d7-4cb9f66ca887/VHD-72fd3b46-3260-4b62-9a91-6501c6d04678 (0 users, state: 0x00000002, type: 4)
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-log: closing after 0 errors
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-syslog: 11 messages, 905 bytes, xmits: 12, failed: 0, dropped: 0
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-control: draining 1 connections
Sep 28 22:25:22 xs-venus tapdisk[28778]: tapdisk-control: done
Скрипт бэкапа перезапускает машину после экспорта.
Отдана команда на экспорт ВМ (лог скрипта бэкапа):
По началу всё одинаково:
А вот тут начинаются различия:
Скрипт бэкапа перезапускает машину после экспорта.
15:07:45 — перезапуск физического сервера
Насколько я смог понять: ovs-vswitchd перезапустил соединение, NFS шара стала недоступна и кто-то стал этим фактом весьма недоволен.
Куда дальше копать пока непонятно.