2026-05-18T21:21:08.375Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-05-18T21:21:08.393Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-05-18T21:21:18.400Z|00003|memory|INFO|7164 kB peak resident set size after 10.0 seconds 2026-05-18T21:21:18.400Z|00004|memory|INFO|atoms:186 cells:131 json-caches:1 monitors:3 n-weak-refs:0 sessions:2 2026-05-18T21:25:14.168Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-05-18T21:25:14.172Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-05-18T21:25:24.186Z|00003|memory|INFO|7812 kB peak resident set size after 10.0 seconds 2026-05-18T21:25:24.186Z|00004|memory|INFO|atoms:807 cells:241 json-caches:3 monitors:6 n-weak-refs:0 sessions:4 2026-05-18T21:38:46.157Z|00005|timeval|WARN|Unreasonably long 1439ms poll interval (0ms user, 1197ms system) 2026-05-18T21:38:46.160Z|00006|timeval|WARN|faults: 27 minor, 116 major 2026-05-18T21:38:46.160Z|00007|timeval|WARN|disk: 25328 reads, 0 writes 2026-05-18T21:38:46.160Z|00008|timeval|WARN|context switches: 118 voluntary, 2200 involuntary 2026-05-18T21:38:46.160Z|00009|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=7f70cdd3: 2026-05-18T21:38:46.160Z|00010|coverage|INFO|util_xalloc 1052.8/sec 1718.383/sec 495.8242/sec total: 1784967 2026-05-18T21:38:46.160Z|00011|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-18T21:38:46.160Z|00012|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-18T21:38:46.160Z|00013|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-18T21:38:46.160Z|00014|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-18T21:38:46.160Z|00015|coverage|INFO|poll_zero_timeout 0.4/sec 0.800/sec 0.2144/sec total: 772 2026-05-18T21:38:46.160Z|00016|coverage|INFO|poll_create_node 19.8/sec 31.967/sec 8.4481/sec total: 30413 2026-05-18T21:38:46.160Z|00017|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-05-18T21:38:46.160Z|00018|coverage|INFO|hmap_expand 18.4/sec 40.417/sec 12.0928/sec total: 43534 2026-05-18T21:38:46.160Z|00019|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0128/sec total: 46 2026-05-18T21:38:46.160Z|00020|coverage|INFO|113 events never hit 2026-05-18T21:39:14.783Z|00021|jsonrpc|WARN|tcp:127.0.0.1:46160: send error: Broken pipe 2026-05-18T21:39:14.784Z|00022|jsonrpc|WARN|tcp:127.0.0.1:49600: send error: Broken pipe 2026-05-18T21:39:14.788Z|00023|timeval|WARN|Unreasonably long 18583ms poll interval (0ms user, 10793ms system) 2026-05-18T21:39:14.788Z|00024|timeval|WARN|faults: 107 minor, 616 major 2026-05-18T21:39:14.788Z|00025|timeval|WARN|disk: 145104 reads, 8 writes 2026-05-18T21:39:14.788Z|00026|timeval|WARN|context switches: 635 voluntary, 13626 involuntary 2026-05-18T21:39:14.789Z|00027|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=e3dad7a2: 2026-05-18T21:39:14.789Z|00028|coverage|INFO|util_xalloc 344.6/sec 1312.583/sec 501.0258/sec total: 1803693 2026-05-18T21:39:14.789Z|00029|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-18T21:39:14.789Z|00030|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-05-18T21:39:14.789Z|00031|coverage|INFO|long_poll_interval 0.0/sec 0.017/sec 0.0003/sec total: 1 2026-05-18T21:39:14.789Z|00032|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-18T21:39:14.789Z|00033|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-05-18T21:39:14.789Z|00034|coverage|INFO|poll_zero_timeout 0.2/sec 0.583/sec 0.2169/sec total: 781 2026-05-18T21:39:14.789Z|00035|coverage|INFO|poll_create_node 6.2/sec 24.183/sec 8.5333/sec total: 30720 2026-05-18T21:39:14.789Z|00036|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-05-18T21:39:14.789Z|00037|coverage|INFO|hmap_expand 8.8/sec 30.817/sec 12.2192/sec total: 43989 2026-05-18T21:39:14.789Z|00038|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0128/sec total: 46 2026-05-18T21:39:14.789Z|00039|coverage|INFO|112 events never hit 2026-05-18T21:39:14.789Z|00040|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:48622) at ../lib/stream-fd.c:157 (51% CPU usage) 2026-05-18T21:39:14.789Z|00041|poll_loop|INFO|wakeup due to [POLLIN] on fd 24 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (51% CPU usage) 2026-05-18T21:39:14.789Z|00042|reconnect|WARN|tcp:127.0.0.1:46160: connection dropped (Broken pipe) 2026-05-18T21:39:14.790Z|00043|reconnect|WARN|tcp:127.0.0.1:49600: connection dropped (Broken pipe) 2026-05-18T21:39:14.794Z|00044|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:48632) at ../lib/stream-fd.c:157 (51% CPU usage) 2026-05-18T21:39:14.820Z|00045|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:48622) at ../lib/stream-fd.c:157 (51% CPU usage) 2026-05-18T21:39:14.823Z|00046|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:48622 (51% CPU usage) 2026-05-18T21:39:14.840Z|00047|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:48632) at ../lib/stream-fd.c:157 (51% CPU usage) 2026-05-18T21:39:14.842Z|00048|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:48632) at ../lib/stream-fd.c:157 (51% CPU usage) 2026-05-18T21:39:16.369Z|00049|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (51% CPU usage) 2026-05-18T21:39:16.374Z|00050|poll_loop|INFO|wakeup due to [POLLIN] on fd 23 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (51% CPU usage) 2026-05-18T21:39:16.400Z|00051|poll_loop|INFO|wakeup due to [POLLIN] on fd 23 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (51% CPU usage)