2026-06-22T14:18:52.486Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-06-22T14:18:52.502Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-06-22T14:19:02.511Z|00003|memory|INFO|7348 kB peak resident set size after 10.0 seconds 2026-06-22T14:19:02.511Z|00004|memory|INFO|atoms:186 cells:131 json-caches:1 monitors:3 n-weak-refs:0 sessions:2 2026-06-22T14:23:27.908Z|00001|vlog|INFO|opened log file /var/log/openvswitch/ovsdb-server.log 2026-06-22T14:23:27.912Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 3.3.4 2026-06-22T14:23:37.917Z|00003|memory|INFO|7988 kB peak resident set size after 10.0 seconds 2026-06-22T14:23:37.917Z|00004|memory|INFO|atoms:805 cells:241 json-caches:3 monitors:6 n-weak-refs:0 sessions:4 2026-06-22T14:27:35.993Z|00005|timeval|WARN|Unreasonably long 1565ms poll interval (0ms user, 1281ms system) 2026-06-22T14:27:35.999Z|00006|timeval|WARN|faults: 178 minor, 1301 major 2026-06-22T14:27:36.000Z|00007|timeval|WARN|disk: 305936 reads, 0 writes 2026-06-22T14:27:36.000Z|00008|timeval|WARN|context switches: 1325 voluntary, 254 involuntary 2026-06-22T14:27:36.072Z|00009|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=640df49a: 2026-06-22T14:27:36.125Z|00010|coverage|INFO|util_xalloc 215.4/sec 1650.233/sec 55.3364/sec total: 200535 2026-06-22T14:27:36.125Z|00011|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:27:36.125Z|00012|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:27:36.125Z|00013|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:27:36.125Z|00014|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:27:36.125Z|00015|coverage|INFO|poll_zero_timeout 0.4/sec 0.867/sec 0.0369/sec total: 135 2026-06-22T14:27:36.125Z|00016|coverage|INFO|poll_create_node 16.2/sec 31.683/sec 1.3119/sec total: 4739 2026-06-22T14:27:36.125Z|00017|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-22T14:27:36.125Z|00018|coverage|INFO|hmap_expand 6.2/sec 45.600/sec 1.7106/sec total: 6190 2026-06-22T14:27:36.125Z|00019|coverage|INFO|hmap_pathological 0.0/sec 0.033/sec 0.0008/sec total: 3 2026-06-22T14:27:36.125Z|00020|coverage|INFO|113 events never hit 2026-06-22T14:27:36.125Z|00021|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:33444 (81% CPU usage) 2026-06-22T14:27:36.853Z|00022|poll_loop|INFO|wakeup due to 227-ms timeout at ../ovsdb/ovsdb-server.c:400 (81% CPU usage) 2026-06-22T14:29:25.560Z|00023|jsonrpc|WARN|tcp:127.0.0.1:33444: send error: Broken pipe 2026-06-22T14:29:25.561Z|00024|timeval|WARN|Unreasonably long 30819ms poll interval (0ms user, 29262ms system) 2026-06-22T14:29:25.561Z|00025|timeval|WARN|faults: 524 minor, 4979 major 2026-06-22T14:29:25.561Z|00026|timeval|WARN|disk: 1267440 reads, 8 writes 2026-06-22T14:29:25.561Z|00027|timeval|WARN|context switches: 5156 voluntary, 25208 involuntary 2026-06-22T14:29:25.561Z|00028|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=5cda8ce5: 2026-06-22T14:29:25.561Z|00029|coverage|INFO|util_xalloc 322.4/sec 740.900/sec 90.8464/sec total: 327047 2026-06-22T14:29:25.561Z|00030|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:29:25.561Z|00031|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:29:25.561Z|00032|coverage|INFO|long_poll_interval 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-22T14:29:25.561Z|00033|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:29:25.561Z|00034|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:29:25.561Z|00035|coverage|INFO|poll_zero_timeout 1.0/sec 0.333/sec 0.0531/sec total: 191 2026-06-22T14:29:25.561Z|00036|coverage|INFO|poll_create_node 5.6/sec 13.183/sec 1.9908/sec total: 7167 2026-06-22T14:29:25.561Z|00037|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-22T14:29:25.561Z|00038|coverage|INFO|hmap_expand 8.0/sec 15.750/sec 2.5289/sec total: 9104 2026-06-22T14:29:25.561Z|00039|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:29:25.561Z|00040|coverage|INFO|112 events never hit 2026-06-22T14:29:25.561Z|00041|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (95% CPU usage) 2026-06-22T14:29:25.561Z|00042|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (95% CPU usage) 2026-06-22T14:29:25.561Z|00043|reconnect|WARN|tcp:127.0.0.1:33444: connection dropped (Broken pipe) 2026-06-22T14:29:25.562Z|00044|jsonrpc|WARN|tcp:127.0.0.1:35800: send error: Broken pipe 2026-06-22T14:29:25.562Z|00045|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:35800 (95% CPU usage) 2026-06-22T14:29:25.562Z|00046|reconnect|WARN|tcp:127.0.0.1:35800: connection dropped (Broken pipe) 2026-06-22T14:29:25.562Z|00047|jsonrpc|WARN|tcp:127.0.0.1:38894: send error: Broken pipe 2026-06-22T14:29:25.562Z|00048|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:38894 (95% CPU usage) 2026-06-22T14:29:25.562Z|00049|reconnect|WARN|tcp:127.0.0.1:38894: connection dropped (Broken pipe) 2026-06-22T14:29:27.346Z|00050|poll_loop|INFO|wakeup due to [POLLIN] on fd 23 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (95% CPU usage) 2026-06-22T14:29:28.061Z|00051|poll_loop|INFO|wakeup due to 713-ms timeout at ../ovsdb/ovsdb-server.c:400 (95% CPU usage) 2026-06-22T14:29:28.061Z|00052|poll_loop|INFO|wakeup due to 0-ms timeout at ../ovsdb/trigger.c:202 (95% CPU usage) 2026-06-22T14:29:28.064Z|00053|poll_loop|INFO|wakeup due to [POLLIN] on fd 23 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (95% CPU usage) 2026-06-22T14:29:37.544Z|00054|timeval|WARN|Unreasonably long 1950ms poll interval (0ms user, 1642ms system) 2026-06-22T14:29:37.550Z|00055|timeval|WARN|faults: 208 minor, 1347 major 2026-06-22T14:29:37.556Z|00056|timeval|WARN|disk: 319264 reads, 0 writes 2026-06-22T14:29:37.561Z|00057|timeval|WARN|context switches: 1383 voluntary, 603 involuntary 2026-06-22T14:29:37.562Z|00058|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=4c23b453: 2026-06-22T14:29:37.562Z|00059|coverage|INFO|util_xalloc 2254.4/sec 1214.550/sec 100.8592/sec total: 363093 2026-06-22T14:29:37.562Z|00060|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:29:37.562Z|00061|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:29:37.562Z|00062|coverage|INFO|long_poll_interval 0.0/sec 0.017/sec 0.0006/sec total: 2 2026-06-22T14:29:37.562Z|00063|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:29:37.575Z|00064|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:29:37.576Z|00065|coverage|INFO|poll_zero_timeout 1.2/sec 0.517/sec 0.0572/sec total: 206 2026-06-22T14:29:37.576Z|00066|coverage|INFO|poll_create_node 41.8/sec 19.000/sec 2.1328/sec total: 7678 2026-06-22T14:29:37.576Z|00067|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-22T14:29:37.576Z|00068|coverage|INFO|hmap_expand 50.2/sec 26.483/sec 2.7444/sec total: 9880 2026-06-22T14:29:37.577Z|00069|coverage|INFO|hmap_pathological 0.0/sec 0.017/sec 0.0011/sec total: 4 2026-06-22T14:29:37.577Z|00070|coverage|INFO|112 events never hit 2026-06-22T14:29:55.348Z|00071|timeval|WARN|Unreasonably long 1364ms poll interval (0ms user, 1188ms system) 2026-06-22T14:29:55.434Z|00072|timeval|WARN|faults: 92 minor, 788 major 2026-06-22T14:29:55.541Z|00073|timeval|WARN|disk: 198208 reads, 0 writes 2026-06-22T14:29:55.570Z|00074|timeval|WARN|context switches: 810 voluntary, 483 involuntary 2026-06-22T14:29:55.986Z|00075|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=56e8d1c9: 2026-06-22T14:29:56.304Z|00076|coverage|INFO|util_xalloc 566.6/sec 948.600/sec 103.5319/sec total: 373476 2026-06-22T14:29:56.487Z|00077|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:29:56.722Z|00078|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:29:57.156Z|00079|coverage|INFO|long_poll_interval 0.0/sec 0.033/sec 0.0008/sec total: 3 2026-06-22T14:29:57.490Z|00080|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:29:57.947Z|00081|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:29:59.266Z|00082|coverage|INFO|poll_zero_timeout 0.4/sec 0.483/sec 0.0597/sec total: 216 2026-06-22T14:30:00.668Z|00083|coverage|INFO|poll_create_node 18.0/sec 15.450/sec 2.2006/sec total: 7958 2026-06-22T14:30:04.993Z|00084|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-22T14:30:04.994Z|00085|coverage|INFO|hmap_expand 13.8/sec 21.200/sec 2.8094/sec total: 10133 2026-06-22T14:30:04.994Z|00086|coverage|INFO|hmap_pathological 0.0/sec 0.017/sec 0.0011/sec total: 4 2026-06-22T14:30:04.994Z|00087|coverage|INFO|112 events never hit 2026-06-22T14:30:04.994Z|00088|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:30:04.994Z|00089|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:43558) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:30:04.994Z|00090|poll_loop|INFO|wakeup due to [POLLIN] on fd 27 (127.0.0.1:6640<->127.0.0.1:47626) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:30:04.994Z|00091|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (93% CPU usage) 2026-06-22T14:30:04.994Z|00092|jsonrpc|WARN|tcp:127.0.0.1:47626: send error: Broken pipe 2026-06-22T14:30:04.995Z|00093|jsonrpc|WARN|tcp:127.0.0.1:43558: send error: Broken pipe 2026-06-22T14:30:04.995Z|00094|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (93% CPU usage) 2026-06-22T14:30:04.995Z|00095|reconnect|WARN|tcp:127.0.0.1:47626: connection dropped (Broken pipe) 2026-06-22T14:30:04.995Z|00096|reconnect|WARN|tcp:127.0.0.1:43558: connection dropped (Broken pipe) 2026-06-22T14:30:04.996Z|00097|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:60788) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:30:05.014Z|00098|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:60786) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:30:05.016Z|00099|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:60786 (93% CPU usage) 2026-06-22T14:30:05.018Z|00100|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:60788) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:30:05.019Z|00101|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:60788 (93% CPU usage) 2026-06-22T14:30:15.421Z|00102|timeval|WARN|Unreasonably long 2569ms poll interval (0ms user, 2441ms system) 2026-06-22T14:30:15.421Z|00103|timeval|WARN|faults: 32 minor, 125 major 2026-06-22T14:30:15.421Z|00104|timeval|WARN|disk: 29936 reads, 0 writes 2026-06-22T14:30:15.421Z|00105|timeval|WARN|context switches: 131 voluntary, 2480 involuntary 2026-06-22T14:30:15.421Z|00106|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=51548a2f: 2026-06-22T14:30:15.421Z|00107|coverage|INFO|util_xalloc 157.0/sec 1100.567/sec 107.8492/sec total: 388257 2026-06-22T14:30:15.421Z|00108|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:30:15.421Z|00109|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:30:15.421Z|00110|coverage|INFO|long_poll_interval 0.0/sec 0.050/sec 0.0011/sec total: 4 2026-06-22T14:30:15.421Z|00111|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:30:15.421Z|00112|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:30:15.421Z|00113|coverage|INFO|poll_zero_timeout 0.0/sec 0.583/sec 0.0614/sec total: 221 2026-06-22T14:30:15.421Z|00114|coverage|INFO|poll_create_node 5.4/sec 16.333/sec 2.2419/sec total: 8071 2026-06-22T14:30:15.421Z|00115|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-22T14:30:15.421Z|00116|coverage|INFO|hmap_expand 4.2/sec 23.217/sec 2.8842/sec total: 10383 2026-06-22T14:30:15.421Z|00117|coverage|INFO|hmap_pathological 0.0/sec 0.050/sec 0.0017/sec total: 6 2026-06-22T14:30:15.421Z|00118|coverage|INFO|112 events never hit 2026-06-22T14:30:39.449Z|00119|timeval|WARN|Unreasonably long 13664ms poll interval (0ms user, 12045ms system) 2026-06-22T14:30:39.449Z|00120|timeval|WARN|faults: 258 minor, 1075 major 2026-06-22T14:30:39.449Z|00121|timeval|WARN|disk: 258744 reads, 0 writes 2026-06-22T14:30:39.449Z|00122|timeval|WARN|context switches: 1135 voluntary, 10984 involuntary 2026-06-22T14:30:39.449Z|00123|coverage|INFO|Skipping details of duplicate event coverage for hash=51548a2f 2026-06-22T14:30:39.449Z|00124|poll_loop|INFO|Dropped 2 log messages in last 32 seconds (most recently, 32 seconds ago) due to excessive rate 2026-06-22T14:30:39.449Z|00125|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (90% CPU usage) 2026-06-22T14:30:39.449Z|00126|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:60788) at ../lib/stream-fd.c:157 (90% CPU usage) 2026-06-22T14:30:39.449Z|00127|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (90% CPU usage) 2026-06-22T14:30:39.449Z|00128|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:60786) at ../lib/stream-fd.c:157 (90% CPU usage) 2026-06-22T14:30:39.490Z|00129|jsonrpc|WARN|tcp:127.0.0.1:60786: send error: Broken pipe 2026-06-22T14:30:39.490Z|00130|jsonrpc|WARN|tcp:127.0.0.1:60788: send error: Broken pipe 2026-06-22T14:30:39.490Z|00131|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:60786 (90% CPU usage) 2026-06-22T14:30:39.490Z|00132|reconnect|WARN|tcp:127.0.0.1:60786: connection dropped (Broken pipe) 2026-06-22T14:30:39.490Z|00133|reconnect|WARN|tcp:127.0.0.1:60788: connection dropped (Broken pipe) 2026-06-22T14:30:41.580Z|00134|poll_loop|INFO|Dropped 8 log messages in last 2 seconds (most recently, 1 seconds ago) due to excessive rate 2026-06-22T14:30:41.580Z|00135|poll_loop|INFO|wakeup due to [POLLIN] on fd 23 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (90% CPU usage) 2026-06-22T14:30:57.374Z|00136|jsonrpc|WARN|tcp:127.0.0.1:46168: send error: Broken pipe 2026-06-22T14:30:57.375Z|00137|jsonrpc|WARN|tcp:127.0.0.1:46176: send error: Broken pipe 2026-06-22T14:30:57.375Z|00138|timeval|WARN|Unreasonably long 12909ms poll interval (0ms user, 11334ms system) 2026-06-22T14:30:57.375Z|00139|timeval|WARN|faults: 252 minor, 1081 major 2026-06-22T14:30:57.375Z|00140|timeval|WARN|disk: 252648 reads, 8 writes 2026-06-22T14:30:57.375Z|00141|timeval|WARN|context switches: 1154 voluntary, 10767 involuntary 2026-06-22T14:30:57.375Z|00142|poll_loop|INFO|Dropped 2 log messages in last 16 seconds (most recently, 16 seconds ago) due to excessive rate 2026-06-22T14:30:57.375Z|00143|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (87% CPU usage) 2026-06-22T14:30:57.375Z|00144|reconnect|WARN|tcp:127.0.0.1:46168: connection dropped (Broken pipe) 2026-06-22T14:30:57.375Z|00145|reconnect|WARN|tcp:127.0.0.1:46176: connection dropped (Broken pipe) 2026-06-22T14:30:57.390Z|00146|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:33850) at ../lib/stream-fd.c:157 (87% CPU usage) 2026-06-22T14:30:59.876Z|00147|poll_loop|INFO|Dropped 5 log messages in last 2 seconds (most recently, 2 seconds ago) due to excessive rate 2026-06-22T14:30:59.876Z|00148|poll_loop|INFO|wakeup due to 2416-ms timeout at ../ovsdb/ovsdb-server.c:400 (87% CPU usage) 2026-06-22T14:31:04.411Z|00149|timeval|WARN|Unreasonably long 1950ms poll interval (0ms user, 1500ms system) 2026-06-22T14:31:04.580Z|00150|timeval|WARN|faults: 121 minor, 1046 major 2026-06-22T14:31:04.855Z|00151|timeval|WARN|disk: 267832 reads, 0 writes 2026-06-22T14:31:05.061Z|00152|timeval|WARN|context switches: 1076 voluntary, 450 involuntary 2026-06-22T14:31:11.934Z|00153|timeval|WARN|Unreasonably long 6315ms poll interval (0ms user, 5388ms system) 2026-06-22T14:31:15.441Z|00154|timeval|WARN|faults: 329 minor, 1068 major 2026-06-22T14:31:19.010Z|00155|timeval|WARN|disk: 256168 reads, 0 writes 2026-06-22T14:31:21.156Z|00156|timeval|WARN|context switches: 1161 voluntary, 4131 involuntary 2026-06-22T14:31:24.142Z|00157|poll_loop|INFO|Dropped 1 log messages in last 24 seconds (most recently, 24 seconds ago) due to excessive rate 2026-06-22T14:31:28.384Z|00158|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (86% CPU usage) 2026-06-22T14:31:29.734Z|00159|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:33852) at ../lib/stream-fd.c:157 (86% CPU usage) 2026-06-22T14:31:29.734Z|00160|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (86% CPU usage) 2026-06-22T14:31:29.734Z|00161|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:33850) at ../lib/stream-fd.c:157 (86% CPU usage) 2026-06-22T14:31:29.736Z|00162|timeval|WARN|Unreasonably long 6755ms poll interval (0ms user, 6151ms system) 2026-06-22T14:31:29.736Z|00163|timeval|WARN|faults: 116 minor, 407 major 2026-06-22T14:31:29.736Z|00164|timeval|WARN|disk: 93928 reads, 24 writes 2026-06-22T14:31:29.736Z|00165|timeval|WARN|context switches: 427 voluntary, 5491 involuntary 2026-06-22T14:31:29.736Z|00166|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (94% CPU usage) 2026-06-22T14:31:29.736Z|00167|jsonrpc|WARN|tcp:127.0.0.1:33850: send error: Broken pipe 2026-06-22T14:31:29.736Z|00168|jsonrpc|WARN|tcp:127.0.0.1:33852: send error: Broken pipe 2026-06-22T14:31:29.736Z|00169|jsonrpc|WARN|tcp:127.0.0.1:52952: send error: Broken pipe 2026-06-22T14:31:29.736Z|00170|reconnect|WARN|tcp:127.0.0.1:33850: connection dropped (Broken pipe) 2026-06-22T14:31:29.736Z|00171|reconnect|WARN|tcp:127.0.0.1:33852: connection dropped (Broken pipe) 2026-06-22T14:31:29.736Z|00172|reconnect|WARN|tcp:127.0.0.1:52952: connection dropped (Broken pipe) 2026-06-22T14:31:29.736Z|00173|jsonrpc|WARN|tcp:127.0.0.1:52958: send error: Broken pipe 2026-06-22T14:31:29.736Z|00174|reconnect|WARN|tcp:127.0.0.1:52958: connection dropped (Broken pipe) 2026-06-22T14:31:56.773Z|00175|timeval|WARN|Unreasonably long 1796ms poll interval (0ms user, 1522ms system) 2026-06-22T14:31:56.926Z|00176|timeval|WARN|faults: 139 minor, 1034 major 2026-06-22T14:31:56.933Z|00177|timeval|WARN|disk: 252320 reads, 0 writes 2026-06-22T14:31:57.203Z|00178|timeval|WARN|context switches: 1063 voluntary, 631 involuntary 2026-06-22T14:31:57.413Z|00179|coverage|INFO|Dropped 4 log messages in last 60 seconds (most recently, 28 seconds ago) due to excessive rate 2026-06-22T14:32:11.762Z|00180|coverage|INFO|Skipping details of duplicate event coverage for hash=51548a2f 2026-06-22T14:32:17.988Z|00181|poll_loop|INFO|Dropped 9 log messages in last 46 seconds (most recently, 43 seconds ago) due to excessive rate 2026-06-22T14:32:19.601Z|00182|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (79% CPU usage) 2026-06-22T14:32:19.602Z|00183|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:40842) at ../lib/stream-fd.c:157 (79% CPU usage) 2026-06-22T14:32:19.602Z|00184|poll_loop|INFO|wakeup due to [POLLIN] on fd 27 (127.0.0.1:6640<->127.0.0.1:40844) at ../lib/stream-fd.c:157 (79% CPU usage) 2026-06-22T14:32:19.602Z|00185|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (79% CPU usage) 2026-06-22T14:32:19.605Z|00186|jsonrpc|WARN|tcp:127.0.0.1:40842: send error: Broken pipe 2026-06-22T14:32:19.605Z|00187|jsonrpc|WARN|tcp:127.0.0.1:40844: send error: Broken pipe 2026-06-22T14:32:19.606Z|00188|timeval|WARN|Unreasonably long 4042ms poll interval (0ms user, 3771ms system) 2026-06-22T14:32:19.606Z|00189|timeval|WARN|faults: 61 minor, 201 major 2026-06-22T14:32:19.606Z|00190|timeval|WARN|disk: 45904 reads, 8 writes 2026-06-22T14:32:19.606Z|00191|timeval|WARN|context switches: 215 voluntary, 3677 involuntary 2026-06-22T14:32:19.606Z|00192|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (94% CPU usage) 2026-06-22T14:32:19.606Z|00193|reconnect|WARN|tcp:127.0.0.1:40842: connection dropped (Broken pipe) 2026-06-22T14:32:19.606Z|00194|reconnect|WARN|tcp:127.0.0.1:40844: connection dropped (Broken pipe) 2026-06-22T14:32:19.606Z|00195|jsonrpc|WARN|tcp:127.0.0.1:55628: send error: Broken pipe 2026-06-22T14:32:19.606Z|00196|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:55628 (94% CPU usage) 2026-06-22T14:32:19.606Z|00197|reconnect|WARN|tcp:127.0.0.1:55628: connection dropped (Broken pipe) 2026-06-22T14:32:19.614Z|00198|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:55638) at ../lib/stream-fd.c:157 (94% CPU usage) 2026-06-22T14:32:19.629Z|00199|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:55638) at ../lib/stream-fd.c:157 (94% CPU usage) 2026-06-22T14:32:35.722Z|00200|jsonrpc|WARN|tcp:127.0.0.1:55638: send error: Broken pipe 2026-06-22T14:32:35.723Z|00201|jsonrpc|WARN|tcp:127.0.0.1:50058: send error: Broken pipe 2026-06-22T14:32:35.724Z|00202|timeval|WARN|Unreasonably long 10980ms poll interval (2ms user, 10149ms system) 2026-06-22T14:32:35.724Z|00203|timeval|WARN|faults: 120 minor, 576 major 2026-06-22T14:32:35.724Z|00204|timeval|WARN|disk: 136992 reads, 8 writes 2026-06-22T14:32:35.724Z|00205|timeval|WARN|context switches: 602 voluntary, 9943 involuntary 2026-06-22T14:32:35.724Z|00206|poll_loop|INFO|Dropped 8 log messages in last 16 seconds (most recently, 14 seconds ago) due to excessive rate 2026-06-22T14:32:35.724Z|00207|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (93% CPU usage) 2026-06-22T14:32:35.724Z|00208|reconnect|WARN|tcp:127.0.0.1:55638: connection dropped (Broken pipe) 2026-06-22T14:32:35.725Z|00209|reconnect|WARN|tcp:127.0.0.1:50058: connection dropped (Broken pipe) 2026-06-22T14:32:35.726Z|00210|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:40476) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:32:35.744Z|00211|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:40486) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:32:59.221Z|00212|jsonrpc|WARN|tcp:127.0.0.1:40476: send error: Broken pipe 2026-06-22T14:32:59.328Z|00213|jsonrpc|WARN|tcp:127.0.0.1:40486: send error: Broken pipe 2026-06-22T14:32:59.751Z|00214|timeval|WARN|Unreasonably long 8906ms poll interval (5ms user, 7480ms system) 2026-06-22T14:32:59.751Z|00215|timeval|WARN|faults: 633 minor, 2198 major 2026-06-22T14:32:59.751Z|00216|timeval|WARN|disk: 504248 reads, 16 writes 2026-06-22T14:32:59.751Z|00217|timeval|WARN|context switches: 2343 voluntary, 5577 involuntary 2026-06-22T14:32:59.751Z|00218|coverage|INFO|Dropped 2 log messages in last 40 seconds (most recently, 24 seconds ago) due to excessive rate 2026-06-22T14:32:59.752Z|00219|coverage|INFO|Skipping details of duplicate event coverage for hash=51548a2f 2026-06-22T14:32:59.753Z|00220|poll_loop|INFO|Dropped 4 log messages in last 24 seconds (most recently, 21 seconds ago) due to excessive rate 2026-06-22T14:32:59.753Z|00221|poll_loop|INFO|wakeup due to [POLLIN] on fd 27 (127.0.0.1:6640<->127.0.0.1:54732) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-06-22T14:32:59.753Z|00222|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-06-22T14:32:59.827Z|00223|reconnect|WARN|tcp:127.0.0.1:40476: connection dropped (Broken pipe) 2026-06-22T14:33:03.184Z|00224|reconnect|WARN|tcp:127.0.0.1:40486: connection dropped (Broken pipe) 2026-06-22T14:33:13.486Z|00225|timeval|WARN|Unreasonably long 13734ms poll interval (2ms user, 12635ms system) 2026-06-22T14:33:13.487Z|00226|timeval|WARN|faults: 175 minor, 791 major 2026-06-22T14:33:13.487Z|00227|timeval|WARN|disk: 190184 reads, 16 writes 2026-06-22T14:33:13.487Z|00228|timeval|WARN|context switches: 841 voluntary, 11906 involuntary 2026-06-22T14:33:13.487Z|00229|poll_loop|INFO|wakeup due to [POLLIN] on fd 22 (/var/run/openvswitch/db.sock<->) at ../lib/stream-fd.c:157 (92% CPU usage) 2026-06-22T14:33:13.487Z|00230|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (92% CPU usage) 2026-06-22T14:33:13.487Z|00231|jsonrpc|WARN|tcp:127.0.0.1:54732: send error: Broken pipe 2026-06-22T14:33:13.487Z|00232|jsonrpc|WARN|tcp:127.0.0.1:54736: send error: Broken pipe 2026-06-22T14:33:13.487Z|00233|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (92% CPU usage) 2026-06-22T14:33:13.487Z|00234|reconnect|WARN|tcp:127.0.0.1:54732: connection dropped (Broken pipe) 2026-06-22T14:33:13.487Z|00235|reconnect|WARN|tcp:127.0.0.1:54736: connection dropped (Broken pipe) 2026-06-22T14:33:13.488Z|00236|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (127.0.0.1:6640<->127.0.0.1:35968) at ../lib/stream-fd.c:157 (92% CPU usage) 2026-06-22T14:33:26.921Z|00237|timeval|WARN|Unreasonably long 2835ms poll interval (1ms user, 2280ms system) 2026-06-22T14:33:26.922Z|00238|timeval|WARN|faults: 14 minor, 58 major 2026-06-22T14:33:26.922Z|00239|timeval|WARN|disk: 11872 reads, 0 writes 2026-06-22T14:33:26.922Z|00240|timeval|WARN|context switches: 60 voluntary, 2573 involuntary 2026-06-22T14:33:39.054Z|00241|timeval|WARN|Unreasonably long 9615ms poll interval (1ms user, 8146ms system) 2026-06-22T14:33:39.054Z|00242|timeval|WARN|faults: 180 minor, 650 major 2026-06-22T14:33:39.054Z|00243|timeval|WARN|disk: 160320 reads, 0 writes 2026-06-22T14:33:39.054Z|00244|timeval|WARN|context switches: 678 voluntary, 7773 involuntary 2026-06-22T14:33:39.054Z|00245|coverage|INFO|Dropped 2 log messages in last 25 seconds (most recently, 12 seconds ago) due to excessive rate 2026-06-22T14:33:39.054Z|00246|coverage|INFO|Skipping details of duplicate event coverage for hash=51548a2f 2026-06-22T14:33:39.054Z|00247|poll_loop|INFO|Dropped 6 log messages in last 25 seconds (most recently, 23 seconds ago) due to excessive rate 2026-06-22T14:33:39.054Z|00248|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-22T14:33:39.054Z|00249|poll_loop|INFO|wakeup due to [POLLIN][POLLERR][POLLHUP] on fd 26 (127.0.0.1:6640<->) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-06-22T14:33:39.054Z|00250|poll_loop|INFO|wakeup due to [POLLIN][POLLERR][POLLHUP] on fd 28 (127.0.0.1:6640<->) at ../lib/stream-fd.c:157 (84% CPU usage) 2026-06-22T14:33:39.055Z|00251|jsonrpc|WARN|tcp:127.0.0.1:35968: send error: Broken pipe 2026-06-22T14:33:39.055Z|00252|jsonrpc|WARN|tcp:127.0.0.1:35980: send error: Broken pipe 2026-06-22T14:33:39.055Z|00253|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:35968 (84% CPU usage) 2026-06-22T14:33:39.055Z|00254|reconnect|WARN|tcp:127.0.0.1:35968: connection dropped (Broken pipe) 2026-06-22T14:33:39.055Z|00255|reconnect|WARN|tcp:127.0.0.1:35980: connection dropped (Broken pipe) 2026-06-22T14:33:41.839Z|00256|poll_loop|INFO|Dropped 9 log messages in last 3 seconds (most recently, 2 seconds ago) due to excessive rate 2026-06-22T14:33:41.839Z|00257|poll_loop|INFO|wakeup due to 1740-ms timeout at ../ovsdb/ovsdb-server.c:400 (84% CPU usage) 2026-06-22T14:33:49.592Z|00258|timeval|WARN|Unreasonably long 5415ms poll interval (0ms user, 5077ms system) 2026-06-22T14:33:49.593Z|00259|timeval|WARN|faults: 66 minor, 300 major 2026-06-22T14:33:49.593Z|00260|timeval|WARN|disk: 69152 reads, 0 writes 2026-06-22T14:33:49.593Z|00261|timeval|WARN|context switches: 316 voluntary, 5400 involuntary 2026-06-22T14:33:49.595Z|00262|poll_loop|INFO|wakeup due to [POLLIN][POLLERR][POLLHUP] on fd 26 (127.0.0.1:6640<->) at ../lib/stream-fd.c:157 (94% CPU usage) 2026-06-22T14:33:49.596Z|00263|jsonrpc|WARN|tcp:127.0.0.1:34594: receive error: Connection reset by peer 2026-06-22T14:33:49.596Z|00264|reconnect|WARN|tcp:127.0.0.1:34594: connection dropped (Connection reset by peer) 2026-06-22T14:33:56.621Z|00265|timeval|WARN|Unreasonably long 1473ms poll interval (0ms user, 1144ms system) 2026-06-22T14:33:56.622Z|00266|timeval|WARN|faults: 21 minor, 36 major 2026-06-22T14:33:56.622Z|00267|timeval|WARN|disk: 7528 reads, 0 writes 2026-06-22T14:33:56.622Z|00268|timeval|WARN|context switches: 39 voluntary, 1269 involuntary 2026-06-22T14:34:14.641Z|00269|timeval|WARN|Unreasonably long 2823ms poll interval (0ms user, 2361ms system) 2026-06-22T14:34:14.641Z|00270|timeval|WARN|faults: 18 minor, 77 major 2026-06-22T14:34:14.641Z|00271|timeval|WARN|disk: 17480 reads, 0 writes 2026-06-22T14:34:14.641Z|00272|timeval|WARN|context switches: 79 voluntary, 2550 involuntary 2026-06-22T14:34:35.681Z|00273|timeval|WARN|Unreasonably long 3280ms poll interval (0ms user, 3053ms system) 2026-06-22T14:34:35.681Z|00274|timeval|WARN|faults: 22 minor, 101 major 2026-06-22T14:34:35.681Z|00275|timeval|WARN|disk: 22000 reads, 0 writes 2026-06-22T14:34:35.681Z|00276|timeval|WARN|context switches: 105 voluntary, 3049 involuntary 2026-06-22T14:34:38.183Z|00277|poll_loop|INFO|Dropped 5 log messages in last 49 seconds (most recently, 46 seconds ago) due to excessive rate 2026-06-22T14:34:38.183Z|00278|poll_loop|INFO|wakeup due to 2501-ms timeout at ../ovsdb/ovsdb-server.c:400 (54% CPU usage) 2026-06-22T14:34:41.480Z|00279|poll_loop|INFO|wakeup due to 2717-ms timeout at ../lib/reconnect.c:677 (54% CPU usage) 2026-06-22T14:34:51.889Z|00280|jsonrpc|WARN|tcp:127.0.0.1:34608: send error: Broken pipe 2026-06-22T14:34:51.889Z|00281|jsonrpc|WARN|tcp:127.0.0.1:58278: send error: Broken pipe 2026-06-22T14:34:51.890Z|00282|timeval|WARN|Unreasonably long 7649ms poll interval (2ms user, 7037ms system) 2026-06-22T14:34:51.890Z|00283|timeval|WARN|faults: 69 minor, 353 major 2026-06-22T14:34:51.890Z|00284|timeval|WARN|disk: 80784 reads, 8 writes 2026-06-22T14:34:51.890Z|00285|timeval|WARN|context switches: 371 voluntary, 7142 involuntary 2026-06-22T14:34:51.890Z|00286|coverage|INFO|Dropped 4 log messages in last 62 seconds (most recently, 16 seconds ago) due to excessive rate 2026-06-22T14:34:51.890Z|00287|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=17bd4b5c: 2026-06-22T14:34:51.890Z|00288|coverage|INFO|util_xalloc 94.0/sec 378.067/sec 143.2050/sec total: 515538 2026-06-22T14:34:51.890Z|00289|coverage|INFO|unixctl_replied 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:34:51.890Z|00290|coverage|INFO|unixctl_received 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-06-22T14:34:51.890Z|00291|coverage|INFO|long_poll_interval 0.0/sec 0.083/sec 0.0058/sec total: 21 2026-06-22T14:34:51.890Z|00292|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:34:51.890Z|00293|coverage|INFO|seq_change 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-06-22T14:34:51.890Z|00294|coverage|INFO|poll_zero_timeout 0.2/sec 0.150/sec 0.0750/sec total: 270 2026-06-22T14:34:51.890Z|00295|coverage|INFO|poll_create_node 0.8/sec 6.667/sec 2.6664/sec total: 9599 2026-06-22T14:34:51.890Z|00296|coverage|INFO|lockfile_lock 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-06-22T14:34:51.890Z|00297|coverage|INFO|hmap_expand 2.6/sec 7.667/sec 3.5272/sec total: 12698 2026-06-22T14:34:51.890Z|00298|coverage|INFO|hmap_pathological 0.0/sec 0.033/sec 0.0058/sec total: 21 2026-06-22T14:34:51.890Z|00299|coverage|INFO|112 events never hit 2026-06-22T14:34:51.890Z|00300|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:34608 (93% CPU usage) 2026-06-22T14:34:51.890Z|00301|reconnect|WARN|tcp:127.0.0.1:34608: connection dropped (Broken pipe) 2026-06-22T14:34:51.890Z|00302|reconnect|WARN|tcp:127.0.0.1:58278: connection dropped (Broken pipe) 2026-06-22T14:34:52.762Z|00303|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (93% CPU usage) 2026-06-22T14:34:52.762Z|00304|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:38530) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:34:52.764Z|00305|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:38530) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:34:52.780Z|00306|poll_loop|INFO|wakeup due to [POLLIN] on fd 26 (127.0.0.1:6640<->127.0.0.1:38530) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:34:52.781Z|00307|poll_loop|INFO|wakeup due to 0-ms timeout at tcp:127.0.0.1:38530 (93% CPU usage) 2026-06-22T14:34:52.882Z|00308|poll_loop|INFO|wakeup due to [POLLIN] on fd 25 (127.0.0.1:6640<->) at ../lib/stream-fd.c:274 (93% CPU usage) 2026-06-22T14:34:52.886Z|00309|poll_loop|INFO|wakeup due to [POLLIN] on fd 27 (127.0.0.1:6640<->127.0.0.1:38534) at ../lib/stream-fd.c:157 (93% CPU usage) 2026-06-22T14:34:54.406Z|00310|poll_loop|INFO|Dropped 2 log messages in last 2 seconds (most recently, 2 seconds ago) due to excessive rate 2026-06-22T14:34:54.406Z|00311|poll_loop|INFO|wakeup due to 1505-ms timeout at ../ovsdb/ovsdb-server.c:400 (93% CPU usage)