2026-06-16T10:46:23.011Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-06-16T10:46:23.040Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-06-16T10:46:33.068Z|00003|memory|INFO|7348 kB peak resident set size after 10.1 seconds 2026-06-16T10:46:33.068Z|00004|memory|INFO|atoms:186 cells:131 json-caches:1 monitors:3 n-weak-refs:0 sessions:2 2026-06-16T10:50:45.178Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-06-16T10:50:45.184Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-06-16T10:50:55.201Z|00003|memory|INFO|7868 kB peak resident set size after 10.0 seconds 2026-06-16T10:50:55.201Z|00004|memory|INFO|atoms:805 cells:241 json-caches:4 monitors:6 n-weak-refs:0 sessions:4 2026-06-16T11:09:44.561Z|00005|timeval|WARN|Unreasonably long 9305ms poll interval (0ms user, 7508ms system) 2026-06-16T11:09:44.571Z|00006|timeval|WARN|faults: 139 minor, 661 major 2026-06-16T11:09:44.590Z|00007|timeval|WARN|disk: 158952 reads, 0 writes 2026-06-16T11:09:44.590Z|00008|timeval|WARN|context switches: 690 voluntary, 9692 involuntary 2026-06-16T11:09:44.590Z|00009|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=7f70cdd3: 2026-06-16T11:09:44.590Z|00010|coverage|INFO|util_xalloc 36.2/sec 809.850/sec 571.5464/sec total: 2057567 2026-06-16T11:09:44.590Z|00011|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-16T11:09:44.590Z|00012|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-16T11:09:44.590Z|00013|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-16T11:09:44.590Z|00014|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-16T11:09:44.590Z|00015|coverage|INFO|poll_zero_timeout 0.2/sec 0.467/sec 0.2589/sec total: 932 2026-06-16T11:09:44.590Z|00016|coverage|INFO|poll_create_node 4.6/sec 19.100/sec 10.3997/sec total: 37439 2026-06-16T11:09:44.590Z|00017|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-16T11:09:44.590Z|00018|coverage|INFO|hmap_expand 1.4/sec 17.583/sec 13.9317/sec total: 50154 2026-06-16T11:09:44.590Z|00019|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0014/sec total: 5 2026-06-16T11:09:44.590Z|00020|coverage|INFO|113 events never hit 2026-06-16T11:09:44.599Z|00021|poll_loop|INFO|wakeup due to [POLLIN][POLLERR][POLLHUP] on fd 26 (127.0.0.1:6640<->) at ../lib/stream-fd.c:157 (69% CPU usage) 2026-06-16T11:09:44.600Z|00022|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:41638 (69% CPU usage) 2026-06-16T11:09:45.453Z|00023|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (69% CPU usage) 2026-06-16T11:09:46.244Z|00024|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:35462) at ../lib/stream-fd.c:157 (69% CPU usage) 2026-06-16T11:09:46.881Z|00025|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (69% CPU usage) 2026-06-16T11:09:46.925Z|00026|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:35462) at ../lib/stream-fd.c:157 (69% CPU usage) 2026-06-16T11:09:47.629Z|00027|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:35462 (60% CPU usage) 2026-06-16T11:09:52.723Z|00028|timeval|WARN|Unreasonably long 4875ms poll interval (0ms user, 4338ms system) 2026-06-16T11:09:53.906Z|00029|timeval|WARN|faults: 207 minor, 1215 major 2026-06-16T11:09:54.316Z|00030|timeval|WARN|disk: 298224 reads, 8 writes 2026-06-16T11:09:54.920Z|00031|timeval|WARN|context switches: 1262 voluntary, 4244 involuntary 2026-06-16T11:09:58.264Z|00032|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=e3dad7a2: 2026-06-16T11:09:58.264Z|00033|coverage|INFO|util_xalloc 1347.2/sec 880.000/sec 573.4175/sec total: 2064303 2026-06-16T11:09:58.264Z|00034|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-16T11:09:58.264Z|00035|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-16T11:09:58.264Z|00036|coverage|INFO|long_poll_interval 0.2/sec 0.017/sec 0.0003/sec total: 1 2026-06-16T11:09:58.264Z|00037|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-16T11:09:58.264Z|00038|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-16T11:09:58.264Z|00039|coverage|INFO|poll_zero_timeout 0.4/sec 0.467/sec 0.2594/sec total: 934 2026-06-16T11:09:58.264Z|00040|coverage|INFO|poll_create_node 10.2/sec 19.050/sec 10.4139/sec total: 37490 2026-06-16T11:09:58.264Z|00041|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-16T11:09:58.264Z|00042|coverage|INFO|hmap_expand 21.0/sec 18.617/sec 13.9608/sec total: 50259 2026-06-16T11:09:58.264Z|00043|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0014/sec total: 5 2026-06-16T11:09:58.264Z|00044|coverage|INFO|112 events never hit 2026-06-16T11:09:58.264Z|00045|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-06-16T11:09:58.264Z|00046|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:35462) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-06-16T11:10:06.668Z|00047|jsonrpc|WARN|tcp:127.0.0.1:35462: send error: Broken pipe 2026-06-16T11:10:06.669Z|00048|timeval|WARN|Unreasonably long 8405ms poll interval (0ms user, 5421ms system) 2026-06-16T11:10:06.669Z|00049|timeval|WARN|faults: 151 minor, 602 major 2026-06-16T11:10:06.669Z|00050|timeval|WARN|disk: 147008 reads, 8 writes 2026-06-16T11:10:06.669Z|00051|timeval|WARN|context switches: 628 voluntary, 6061 involuntary 2026-06-16T11:10:06.669Z|00052|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=4c23b453: 2026-06-16T11:10:06.669Z|00053|coverage|INFO|util_xalloc 116.4/sec 797.733/sec 573.7408/sec total: 2065467 2026-06-16T11:10:06.669Z|00054|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-16T11:10:06.669Z|00055|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-16T11:10:06.669Z|00056|coverage|INFO|long_poll_interval 0.2/sec 0.033/sec 0.0006/sec total: 2 2026-06-16T11:10:06.669Z|00057|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-16T11:10:06.669Z|00058|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-16T11:10:06.669Z|00059|coverage|INFO|poll_zero_timeout 0.2/sec 0.417/sec 0.2597/sec total: 935 2026-06-16T11:10:06.669Z|00060|coverage|INFO|poll_create_node 0.8/sec 16.483/sec 10.4161/sec total: 37498 2026-06-16T11:10:06.669Z|00061|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-16T11:10:06.669Z|00062|coverage|INFO|hmap_expand 3.4/sec 17.267/sec 13.9700/sec total: 50292 2026-06-16T11:10:06.669Z|00063|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0014/sec total: 5 2026-06-16T11:10:06.669Z|00064|coverage|INFO|112 events never hit 2026-06-16T11:10:06.669Z|00065|poll_loop|INFO|wakeup due to 0-ms timeout at ../lib/reconnect.c:677 (64% CPU usage) 2026-06-16T11:10:06.669Z|00066|reconnect|WARN|tcp:127.0.0.1:35462: connection dropped (Broken pipe) 2026-06-16T11:10:06.672Z|00067|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:41470) at ../lib/stream-fd.c:157 (64% CPU usage) 2026-06-16T11:10:06.699Z|00068|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:41470) at ../lib/stream-fd.c:157 (64% CPU usage) 2026-06-16T11:10:06.700Z|00069|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:41470 (64% CPU usage) 2026-06-16T11:10:09.172Z|00070|poll_loop|INFO|Dropped 7 log messages in last 2 seconds (most recently, 2 seconds ago) due to excessive rate 2026-06-16T11:10:09.172Z|00071|poll_loop|INFO|wakeup due to 2407-ms timeout at ../ovsdb/ovsdb-server.c:400 (64% CPU usage)