2026-05-12T17:18:16.134Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-05-12T17:18:16.146Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-05-12T17:18:26.171Z|00003|memory|INFO|7348 kB peak resident set size after 10.0 seconds 2026-05-12T17:18:26.171Z|00004|memory|INFO|atoms:186 cells:131 json-caches:1 monitors:3 n-weak-refs:0 sessions:2 2026-05-12T17:22:28.184Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-05-12T17:22:28.188Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-05-12T17:22:38.194Z|00003|memory|INFO|7828 kB peak resident set size after 10.0 seconds 2026-05-12T17:22:38.194Z|00004|memory|INFO|atoms:807 cells:241 json-caches:3 monitors:6 n-weak-refs:0 sessions:4 2026-05-12T17:39:08.356Z|00005|timeval|WARN|Unreasonably long 6600ms poll interval (0ms user, 2976ms system) 2026-05-12T17:39:08.356Z|00006|timeval|WARN|faults: 49 minor, 183 major 2026-05-12T17:39:08.356Z|00007|timeval|WARN|disk: 44448 reads, 0 writes 2026-05-12T17:39:08.356Z|00008|timeval|WARN|context switches: 191 voluntary, 3419 involuntary 2026-05-12T17:39:08.356Z|00009|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=7f70cdd3: 2026-05-12T17:39:08.356Z|00010|coverage|INFO|util_xalloc 694.2/sec 1525.717/sec 563.2128/sec total: 2027566 2026-05-12T17:39:08.356Z|00011|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-12T17:39:08.356Z|00012|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-12T17:39:08.356Z|00013|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-12T17:39:08.356Z|00014|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-12T17:39:08.356Z|00015|coverage|INFO|poll_zero_timeout 0.4/sec 0.733/sec 0.2464/sec total: 887 2026-05-12T17:39:08.356Z|00016|coverage|INFO|poll_create_node 14.4/sec 29.217/sec 9.7592/sec total: 35133 2026-05-12T17:39:08.356Z|00017|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-05-12T17:39:08.356Z|00018|coverage|INFO|hmap_expand 14.4/sec 35.783/sec 13.6461/sec total: 49126 2026-05-12T17:39:08.356Z|00019|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0078/sec total: 28 2026-05-12T17:39:08.356Z|00020|coverage|INFO|113 events never hit 2026-05-12T17:39:38.688Z|00021|timeval|WARN|Unreasonably long 13042ms poll interval (0ms user, 10990ms system) 2026-05-12T17:39:38.688Z|00022|timeval|WARN|faults: 253 minor, 1093 major 2026-05-12T17:39:38.688Z|00023|timeval|WARN|disk: 256872 reads, 0 writes 2026-05-12T17:39:38.688Z|00024|timeval|WARN|context switches: 1125 voluntary, 10368 involuntary 2026-05-12T17:39:38.688Z|00025|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=e3dad7a2: 2026-05-12T17:39:38.688Z|00026|coverage|INFO|util_xalloc 116.6/sec 597.733/sec 567.0578/sec total: 2041408 2026-05-12T17:39:38.688Z|00027|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-12T17:39:38.688Z|00028|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-12T17:39:38.688Z|00029|coverage|INFO|long_poll_interval 0.0/sec 0.017/sec 0.0003/sec total: 1 2026-05-12T17:39:38.688Z|00030|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-12T17:39:38.688Z|00031|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-12T17:39:38.688Z|00032|coverage|INFO|poll_zero_timeout 0.0/sec 0.350/sec 0.2483/sec total: 894 2026-05-12T17:39:38.688Z|00033|coverage|INFO|poll_create_node 1.8/sec 15.183/sec 9.8519/sec total: 35467 2026-05-12T17:39:38.688Z|00034|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-05-12T17:39:38.688Z|00035|coverage|INFO|hmap_expand 2.6/sec 13.700/sec 13.7389/sec total: 49460 2026-05-12T17:39:38.688Z|00036|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0078/sec total: 28 2026-05-12T17:39:38.688Z|00037|coverage|INFO|112 events never hit 2026-05-12T17:39:38.688Z|00038|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-05-12T17:39:38.688Z|00039|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:38546) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-05-12T17:39:38.688Z|00040|poll_loop|INFO|wakeup due to [POLLIN][POLLERR][POLLHUP] on fd 27 (127.0.0.1:6640<->) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-05-12T17:39:38.688Z|00041|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (84% CPU usage) 2026-05-12T17:39:39.937Z|00042|jsonrpc|WARN|tcp:127.0.0.1:49082: send error: Broken pipe 2026-05-12T17:39:40.390Z|00043|timeval|WARN|Unreasonably long 1694ms poll interval (0ms user, 1338ms system) 2026-05-12T17:39:40.399Z|00044|timeval|WARN|faults: 190 minor, 1254 major 2026-05-12T17:39:40.402Z|00045|timeval|WARN|disk: 292808 reads, 8 writes 2026-05-12T17:39:40.402Z|00046|timeval|WARN|context switches: 1273 voluntary, 600 involuntary 2026-05-12T17:39:40.402Z|00047|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=4c23b453: 2026-05-12T17:39:40.402Z|00048|coverage|INFO|util_xalloc 116.6/sec 597.733/sec 567.0578/sec total: 2042729 2026-05-12T17:39:40.402Z|00049|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-12T17:39:40.402Z|00050|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-12T17:39:40.402Z|00051|coverage|INFO|long_poll_interval 0.0/sec 0.017/sec 0.0003/sec total: 2 2026-05-12T17:39:40.402Z|00052|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-12T17:39:40.402Z|00053|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-12T17:39:40.402Z|00054|coverage|INFO|poll_zero_timeout 0.0/sec 0.350/sec 0.2483/sec total: 895 2026-05-12T17:39:40.402Z|00055|coverage|INFO|poll_create_node 1.8/sec 15.183/sec 9.8519/sec total: 35476 2026-05-12T17:39:40.402Z|00056|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-05-12T17:39:40.402Z|00057|coverage|INFO|hmap_expand 2.6/sec 13.700/sec 13.7389/sec total: 49495 2026-05-12T17:39:40.402Z|00058|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0078/sec total: 28 2026-05-12T17:39:40.402Z|00059|coverage|INFO|112 events never hit 2026-05-12T17:39:40.402Z|00060|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:55388) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-05-12T17:39:40.443Z|00061|reconnect|WARN|tcp:127.0.0.1:49082: connection dropped (Broken pipe) 2026-05-12T17:39:40.499Z|00062|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:55388) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-05-12T17:39:40.659Z|00063|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:55388 (84% CPU usage) 2026-05-12T17:39:41.246Z|00064|poll_loop|INFO|wakeup due to 515-ms timeout at ../ovsdb/ovsdb-server.c:400 (84% CPU usage) 2026-05-12T17:39:47.553Z|00065|timeval|WARN|Unreasonably long 1242ms poll interval (0ms user, 298ms system) 2026-05-12T17:39:47.553Z|00066|timeval|WARN|faults: 13 minor, 13 major 2026-05-12T17:39:47.553Z|00067|timeval|WARN|disk: 2696 reads, 0 writes 2026-05-12T17:39:47.553Z|00068|timeval|WARN|context switches: 15 voluntary, 431 involuntary