2026-06-22T12:47:29.591Z|00001|vlog|INFO|opened log file /var/log/ovn/ovn-controller.log
2026-06-22T12:47:29.593Z|00002|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T12:47:29.593Z|00003|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T12:47:29.606Z|00004|main|INFO|OVN internal version is : [24.03.6-20.33.0-76.8]
2026-06-22T12:47:29.606Z|00005|main|INFO|OVS IDL reconnected, force recompute.
2026-06-22T12:47:29.606Z|00006|main|INFO|OVNSB IDL reconnected, force recompute.
2026-06-22T12:51:52.372Z|00007|memory|INFO|8076 kB peak resident set size after 262.8 seconds
2026-06-22T12:51:52.372Z|00008|memory|INFO|idl-cells-Open_vSwitch:101
2026-06-22T12:51:52.373Z|00009|jsonrpc|WARN|unix:/var/run/openvswitch/db.sock: send error: Broken pipe
2026-06-22T12:51:52.374Z|00010|reconnect|WARN|unix:/var/run/openvswitch/db.sock: connection dropped (Broken pipe)
2026-06-22T12:51:53.375Z|00011|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T12:51:53.375Z|00012|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T12:51:53.481Z|00013|reconnect|INFO|ssl:10.4.3.109:6642: connecting...
2026-06-22T12:51:53.481Z|00014|reconnect|INFO|ssl:10.4.3.109:6642: connection attempt failed (Connection refused)
2026-06-22T12:51:54.483Z|00015|reconnect|INFO|ssl:10.4.3.109:6642: connecting...
2026-06-22T12:51:54.483Z|00016|reconnect|INFO|ssl:10.4.3.109:6642: connection attempt failed (Connection refused)
2026-06-22T12:51:54.483Z|00017|reconnect|INFO|ssl:10.4.3.109:6642: waiting 2 seconds before reconnect
2026-06-22T12:51:56.407Z|00001|vlog|INFO|opened log file /var/log/ovn/ovn-controller.log
2026-06-22T12:51:56.409Z|00002|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T12:51:56.409Z|00003|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T12:51:56.412Z|00004|main|INFO|OVN internal version is : [24.03.6-20.33.0-76.8]
2026-06-22T12:51:56.412Z|00005|main|INFO|OVS IDL reconnected, force recompute.
2026-06-22T12:51:56.416Z|00006|reconnect|INFO|ssl:10.4.3.109:6642: connecting...
2026-06-22T12:51:56.416Z|00007|main|INFO|OVNSB IDL reconnected, force recompute.
2026-06-22T12:51:56.420Z|00008|reconnect|INFO|ssl:10.4.3.109:6642: connected
2026-06-22T12:51:56.424Z|00009|features|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T12:51:56.424Z|00010|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T12:51:56.424Z|00011|features|INFO|OVS Feature: ct_zero_snat, state: supported
2026-06-22T12:51:56.424Z|00012|features|INFO|OVS Feature: ct_flush, state: supported
2026-06-22T12:51:56.424Z|00013|features|INFO|OVS Feature: dp_hash_l4_sym_support, state: supported
2026-06-22T12:51:56.424Z|00014|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T12:51:56.424Z|00015|main|INFO|OVS feature set changed, force recompute.
2026-06-22T12:51:56.425Z|00016|ofctrl|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T12:51:56.425Z|00017|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T12:51:56.425Z|00018|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T12:51:56.425Z|00019|main|INFO|OVS OpenFlow connection reconnected,force recompute.
2026-06-22T12:51:56.426Z|00020|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T12:51:56.426Z|00021|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T12:51:56.426Z|00022|main|INFO|OVS feature set changed, force recompute.
2026-06-22T12:51:56.426Z|00001|pinctrl(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T12:51:56.426Z|00002|rconn(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T12:51:56.426Z|00001|statctrl(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T12:51:56.426Z|00002|rconn(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T12:51:56.427Z|00003|rconn(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T12:51:56.427Z|00003|rconn(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T12:51:56.427Z|00023|features|INFO|OVS DB schema supports 4 flow table prefixes, our IDL supports: 4
2026-06-22T12:51:56.428Z|00024|main|INFO|Setting flow table prefixes: ip_src, ip_dst, ipv6_src, ipv6_dst.
2026-06-22T12:52:10.612Z|00025|memory|INFO|9996 kB peak resident set size after 14.2 seconds
2026-06-22T12:52:10.612Z|00026|memory|INFO|idl-cells-OVN_Southbound:226 idl-cells-Open_vSwitch:191 ofctrl_desired_flow_usage-KB:4 ofctrl_installed_flow_usage-KB:3 ofctrl_sb_flow_ref_usage-KB:2
2026-06-22T12:52:21.764Z|00027|binding|INFO|Claiming lport cr-lrp-0d3aba94-af21-4336-a0e2-d0cc75561b2e for this chassis.
2026-06-22T12:52:21.764Z|00028|binding|INFO|cr-lrp-0d3aba94-af21-4336-a0e2-d0cc75561b2e: Claiming fa:16:3e:6f:a5:1a 172.24.5.149/24
2026-06-22T12:52:21.770Z|00029|binding|INFO|Setting lport cr-lrp-0d3aba94-af21-4336-a0e2-d0cc75561b2e up in Southbound
2026-06-22T12:52:56.065Z|00030|memory_trim|INFO|Detected inactivity (last active 30003 ms ago): trimming memory
2026-06-22T12:53:58.025Z|00031|memory_trim|INFO|Detected inactivity (last active 30002 ms ago): trimming memory
2026-06-22T12:55:00.464Z|00032|binding|INFO|Claiming lport cr-lrp-526ed3a8-701d-49bf-ac44-73ccd9145ac5 for this chassis.
2026-06-22T12:55:00.464Z|00033|binding|INFO|cr-lrp-526ed3a8-701d-49bf-ac44-73ccd9145ac5: Claiming fa:16:3e:6b:86:99 172.24.5.47/24 2001:db8::2d6/64
2026-06-22T12:55:00.474Z|00034|binding|INFO|Setting lport cr-lrp-526ed3a8-701d-49bf-ac44-73ccd9145ac5 up in Southbound
2026-06-22T12:55:00.808Z|00035|binding|INFO|Claiming lport cr-lrp-6c7c6bf2-27cd-495c-b2b9-55d65f5ad5b1 for this chassis.
2026-06-22T12:55:00.808Z|00036|binding|INFO|cr-lrp-6c7c6bf2-27cd-495c-b2b9-55d65f5ad5b1: Claiming fa:16:3e:af:e6:2e 172.24.5.97/24 2001:db8::1a8/64
2026-06-22T12:55:00.814Z|00037|binding|INFO|Setting lport cr-lrp-6c7c6bf2-27cd-495c-b2b9-55d65f5ad5b1 up in Southbound
2026-06-22T12:55:01.016Z|00038|binding|INFO|Claiming lport cr-lrp-64974d41-a342-4347-bcc8-9a804e1dacc1 for this chassis.
2026-06-22T12:55:01.016Z|00039|binding|INFO|cr-lrp-64974d41-a342-4347-bcc8-9a804e1dacc1: Claiming fa:16:3e:89:be:c5 172.24.5.214/24 2001:db8::3a2/64
2026-06-22T12:55:01.022Z|00040|binding|INFO|Setting lport cr-lrp-64974d41-a342-4347-bcc8-9a804e1dacc1 up in Southbound
2026-06-22T12:55:02.466Z|00041|binding|INFO|Claiming lport cr-lrp-1ad447d2-cf9a-4d00-98dd-25a099b30058 for this chassis.
2026-06-22T12:55:02.466Z|00042|binding|INFO|cr-lrp-1ad447d2-cf9a-4d00-98dd-25a099b30058: Claiming fa:16:3e:f6:7e:fd 172.24.5.72/24 2001:db8::344/64
2026-06-22T12:55:02.477Z|00043|binding|INFO|Setting lport cr-lrp-1ad447d2-cf9a-4d00-98dd-25a099b30058 up in Southbound
2026-06-22T12:55:02.863Z|00044|binding|INFO|Claiming lport cr-lrp-103bb7c7-1c13-4495-b18f-f873131120e2 for this chassis.
2026-06-22T12:55:02.863Z|00045|binding|INFO|cr-lrp-103bb7c7-1c13-4495-b18f-f873131120e2: Claiming fa:16:3e:b7:96:ff 172.24.5.136/24 2001:db8::c6/64
2026-06-22T12:55:02.868Z|00046|binding|INFO|Setting lport cr-lrp-103bb7c7-1c13-4495-b18f-f873131120e2 up in Southbound
2026-06-22T12:55:03.294Z|00047|binding|INFO|Claiming lport cr-lrp-37952c13-ccbd-4485-adaa-0e39876037bb for this chassis.
2026-06-22T12:55:03.294Z|00048|binding|INFO|cr-lrp-37952c13-ccbd-4485-adaa-0e39876037bb: Claiming fa:16:3e:09:77:2f 172.24.5.24/24 2001:db8::1bc/64
2026-06-22T12:55:03.298Z|00049|binding|INFO|Setting lport cr-lrp-37952c13-ccbd-4485-adaa-0e39876037bb up in Southbound
2026-06-22T12:55:04.922Z|00050|binding|INFO|Claiming lport cr-lrp-0b85f0ad-cea7-4053-963d-88669f7c42d7 for this chassis.
2026-06-22T12:55:04.922Z|00051|binding|INFO|cr-lrp-0b85f0ad-cea7-4053-963d-88669f7c42d7: Claiming fa:16:3e:5f:38:26 172.24.5.74/24 2001:db8::2ea/64
2026-06-22T12:55:04.928Z|00052|binding|INFO|Setting lport cr-lrp-0b85f0ad-cea7-4053-963d-88669f7c42d7 up in Southbound
2026-06-22T12:55:12.448Z|00053|memory|INFO|peak resident set size grew 78% in last 181.8 seconds, from 9996 kB to 17804 kB
2026-06-22T12:55:12.448Z|00054|memory|INFO|idl-cells-OVN_Southbound:11476 idl-cells-Open_vSwitch:305 if_status_mgr_ifaces_state_usage-KB:1 if_status_mgr_ifaces_usage-KB:2 lflow-cache-entries-cache-expr:590 lflow-cache-entries-cache-matches:266 lflow-cache-size-KB:2646 local_datapath_usage-KB:3 ofctrl_desired_flow_usage-KB:717 ofctrl_installed_flow_usage-KB:534 ofctrl_sb_flow_ref_usage-KB:264
2026-06-22T12:55:12.449Z|00055|binding|INFO|Claiming lport cr-lrp-2f421a49-0ead-4f67-b60b-70ce9a6419ab for this chassis.
2026-06-22T12:55:12.449Z|00056|binding|INFO|cr-lrp-2f421a49-0ead-4f67-b60b-70ce9a6419ab: Claiming fa:16:3e:6a:7f:dc 172.24.5.111/24 2001:db8::199/64
2026-06-22T12:55:12.459Z|00057|binding|INFO|Setting lport cr-lrp-2f421a49-0ead-4f67-b60b-70ce9a6419ab up in Southbound
2026-06-22T12:55:12.671Z|00058|binding|INFO|Claiming lport cr-lrp-f1732ae1-7a1b-410c-8d99-3b11110332bc for this chassis.
2026-06-22T12:55:12.671Z|00059|binding|INFO|cr-lrp-f1732ae1-7a1b-410c-8d99-3b11110332bc: Claiming fa:16:3e:5b:21:e9 172.24.5.238/24 2001:db8::f9/64
2026-06-22T12:55:12.684Z|00060|binding|INFO|Setting lport cr-lrp-f1732ae1-7a1b-410c-8d99-3b11110332bc up in Southbound
2026-06-22T12:55:13.175Z|00061|binding|INFO|Claiming lport cr-lrp-9c3cdb4f-01c0-41de-ae39-09dfd7902b39 for this chassis.
2026-06-22T12:55:13.175Z|00062|binding|INFO|cr-lrp-9c3cdb4f-01c0-41de-ae39-09dfd7902b39: Claiming fa:16:3e:3a:5a:6a 172.24.5.118/24 2001:db8::29e/64
2026-06-22T12:55:13.183Z|00063|binding|INFO|Setting lport cr-lrp-9c3cdb4f-01c0-41de-ae39-09dfd7902b39 up in Southbound
2026-06-22T12:55:13.942Z|00064|binding|INFO|Claiming lport cr-lrp-5fc1ad4b-8a3a-4d2e-8407-51e0476d8ad3 for this chassis.
2026-06-22T12:55:13.942Z|00065|binding|INFO|cr-lrp-5fc1ad4b-8a3a-4d2e-8407-51e0476d8ad3: Claiming fa:16:3e:28:a0:b8 172.24.5.153/24 2001:db8::116/64
2026-06-22T12:55:13.953Z|00066|binding|INFO|Setting lport cr-lrp-5fc1ad4b-8a3a-4d2e-8407-51e0476d8ad3 up in Southbound
2026-06-22T12:55:17.055Z|00067|binding|INFO|Claiming lport cr-lrp-a2b6447e-d7c1-42f8-85dc-5ef48916dd83 for this chassis.
2026-06-22T12:55:17.055Z|00068|binding|INFO|cr-lrp-a2b6447e-d7c1-42f8-85dc-5ef48916dd83: Claiming fa:16:3e:d0:dc:eb 172.24.5.120/24 2001:db8::306/64
2026-06-22T12:55:17.071Z|00069|binding|INFO|Setting lport cr-lrp-a2b6447e-d7c1-42f8-85dc-5ef48916dd83 up in Southbound
2026-06-22T12:55:22.138Z|00070|binding|INFO|Claiming lport cr-lrp-a3ddf623-c99c-4e21-a3ba-56a85276148f for this chassis.
2026-06-22T12:55:22.138Z|00071|binding|INFO|cr-lrp-a3ddf623-c99c-4e21-a3ba-56a85276148f: Claiming fa:16:3e:43:17:86 172.24.5.90/24 2001:db8::3d8/64
2026-06-22T12:55:22.152Z|00072|binding|INFO|Setting lport cr-lrp-a3ddf623-c99c-4e21-a3ba-56a85276148f up in Southbound
2026-06-22T12:55:23.057Z|00073|binding|INFO|Claiming lport cr-lrp-35c9c5ba-2640-46b6-adae-0c1baeb1bc17 for this chassis.
2026-06-22T12:55:23.057Z|00074|binding|INFO|cr-lrp-35c9c5ba-2640-46b6-adae-0c1baeb1bc17: Claiming fa:16:3e:f8:7e:f6 172.24.5.170/24 2001:db8::24c/64
2026-06-22T12:55:23.069Z|00075|binding|INFO|Setting lport cr-lrp-35c9c5ba-2640-46b6-adae-0c1baeb1bc17 up in Southbound
2026-06-22T12:55:25.756Z|00076|binding|INFO|Claiming lport cr-lrp-ca79b497-412b-4a1a-a5cf-c91bea64a6ab for this chassis.
2026-06-22T12:55:25.756Z|00077|binding|INFO|cr-lrp-ca79b497-412b-4a1a-a5cf-c91bea64a6ab: Claiming fa:16:3e:d4:62:ac 172.24.5.186/24 2001:db8::152/64
2026-06-22T12:55:25.769Z|00078|binding|INFO|Setting lport cr-lrp-ca79b497-412b-4a1a-a5cf-c91bea64a6ab up in Southbound
2026-06-22T12:55:36.142Z|00079|binding|INFO|Claiming lport 7a8e33a3-80ca-4862-9f73-44aee99b3af7 for this chassis.
2026-06-22T12:55:36.142Z|00080|binding|INFO|7a8e33a3-80ca-4862-9f73-44aee99b3af7: Claiming fa:16:3e:3c:d9:27 10.1.0.6
2026-06-22T12:55:36.165Z|00081|binding|INFO|Setting lport 7a8e33a3-80ca-4862-9f73-44aee99b3af7 ovn-installed in OVS
2026-06-22T12:55:36.165Z|00082|binding|INFO|Setting lport 7a8e33a3-80ca-4862-9f73-44aee99b3af7 up in Southbound
2026-06-22T12:55:36.405Z|00083|binding|INFO|Claiming lport aba451cf-ecff-49c5-b6f5-4b3bfdccb36a for this chassis.
2026-06-22T12:55:36.405Z|00084|binding|INFO|aba451cf-ecff-49c5-b6f5-4b3bfdccb36a: Claiming fa:16:3e:a0:1e:08 10.1.0.13
2026-06-22T12:55:36.430Z|00085|binding|INFO|Setting lport aba451cf-ecff-49c5-b6f5-4b3bfdccb36a ovn-installed in OVS
2026-06-22T12:55:36.430Z|00086|binding|INFO|Setting lport aba451cf-ecff-49c5-b6f5-4b3bfdccb36a up in Southbound
2026-06-22T12:55:47.360Z|00087|timeval|WARN|Unreasonably long 4252ms poll interval (3ms user, 3674ms system)
2026-06-22T12:55:47.361Z|00088|timeval|WARN|faults: 250 minor, 1842 major
2026-06-22T12:55:47.361Z|00089|timeval|WARN|disk: 464216 reads, 0 writes
2026-06-22T12:55:47.361Z|00090|timeval|WARN|context switches: 1858 voluntary, 2537 involuntary
2026-06-22T12:55:47.361Z|00091|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=0720083c:
2026-06-22T12:55:47.361Z|00092|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:55:47.361Z|00093|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:55:47.361Z|00094|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:55:47.361Z|00095|coverage|INFO|vconn_sent                 0.0/sec   119.783/sec        2.1731/sec   total: 8113
2026-06-22T12:55:47.361Z|00096|coverage|INFO|vconn_received             0.0/sec     4.933/sec        0.0947/sec   total: 347
2026-06-22T12:55:47.361Z|00097|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T12:55:47.361Z|00098|coverage|INFO|util_xalloc               37.6/sec 34126.983/sec      619.5486/sec   total: 2390408
2026-06-22T12:55:47.361Z|00099|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0019/sec   total: 7
2026-06-22T12:55:47.361Z|00100|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T12:55:47.361Z|00101|coverage|INFO|seq_change                 9.4/sec    47.600/sec        1.0664/sec   total: 3861
2026-06-22T12:55:47.361Z|00102|coverage|INFO|rconn_sent                 0.0/sec   119.783/sec        2.1719/sec   total: 8109
2026-06-22T12:55:47.361Z|00103|coverage|INFO|rconn_queued               0.0/sec   119.783/sec        2.1719/sec   total: 8109
2026-06-22T12:55:47.361Z|00104|coverage|INFO|poll_zero_timeout          0.0/sec     0.683/sec        0.0286/sec   total: 105
2026-06-22T12:55:47.361Z|00105|coverage|INFO|poll_create_node          18.8/sec   140.533/sec        3.1814/sec   total: 11547
2026-06-22T12:55:47.361Z|00106|coverage|INFO|txn_success                0.0/sec     0.917/sec        0.0189/sec   total: 69
2026-06-22T12:55:47.361Z|00107|coverage|INFO|txn_incomplete             0.0/sec     1.600/sec        0.0358/sec   total: 130
2026-06-22T12:55:47.361Z|00108|coverage|INFO|txn_unchanged              0.0/sec    12.900/sec        0.3056/sec   total: 1119
2026-06-22T12:55:47.361Z|00109|coverage|INFO|hmap_reserve               0.0/sec     2.250/sec        0.0375/sec   total: 174
2026-06-22T12:55:47.361Z|00110|coverage|INFO|hmap_expand                0.0/sec   507.050/sec        9.7103/sec   total: 38104
2026-06-22T12:55:47.361Z|00111|coverage|INFO|hmap_pathological          0.0/sec     7.267/sec        0.1336/sec   total: 496
2026-06-22T12:55:47.361Z|00112|coverage|INFO|miniflow_malloc            0.0/sec  1193.617/sec       20.5875/sec   total: 79485
2026-06-22T12:55:47.361Z|00113|coverage|INFO|physical_run               0.0/sec     1.033/sec        0.0194/sec   total: 71
2026-06-22T12:55:47.361Z|00114|coverage|INFO|lflow_conj_free            0.0/sec     0.067/sec        0.0011/sec   total: 4
2026-06-22T12:55:47.361Z|00115|coverage|INFO|lflow_conj_alloc           0.0/sec     0.100/sec        0.0017/sec   total: 8
2026-06-22T12:55:47.361Z|00116|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:55:47.361Z|00117|coverage|INFO|lflow_cache_delete         0.0/sec    48.883/sec        0.8347/sec   total: 3047
2026-06-22T12:55:47.361Z|00118|coverage|INFO|lflow_cache_miss           0.0/sec   100.633/sec        1.7839/sec   total: 6593
2026-06-22T12:55:47.361Z|00119|coverage|INFO|lflow_cache_hit            0.0/sec   510.967/sec        8.7344/sec   total: 34661
2026-06-22T12:55:47.361Z|00120|coverage|INFO|lflow_cache_add            0.0/sec    68.217/sec        1.2272/sec   total: 4419
2026-06-22T12:55:47.361Z|00121|coverage|INFO|lflow_cache_free_matches   0.0/sec    43.517/sec        0.7444/sec   total: 2689
2026-06-22T12:55:47.361Z|00122|coverage|INFO|lflow_cache_free_expr      0.0/sec     5.367/sec        0.0903/sec   total: 358
2026-06-22T12:55:47.361Z|00123|coverage|INFO|lflow_cache_add_matches    0.0/sec    47.733/sec        0.8572/sec   total: 3086
2026-06-22T12:55:47.361Z|00124|coverage|INFO|lflow_cache_add_expr       0.0/sec    20.483/sec        0.3700/sec   total: 1333
2026-06-22T12:55:47.361Z|00125|coverage|INFO|consider_logical_flow      0.0/sec   126.283/sec        2.3286/sec   total: 9844
2026-06-22T12:55:47.361Z|00126|coverage|INFO|lflow_run                  0.0/sec     0.033/sec        0.0014/sec   total: 6
2026-06-22T12:55:47.361Z|00127|coverage|INFO|116 events never hit
2026-06-22T12:55:47.361Z|00128|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (87% CPU usage)
2026-06-22T12:55:47.746Z|00129|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (87% CPU usage)
2026-06-22T12:55:47.757Z|00130|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (87% CPU usage)
2026-06-22T12:55:47.761Z|00131|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (87% CPU usage)
2026-06-22T12:55:47.761Z|00132|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:55:47.762Z|00133|poll_loop|INFO|wakeup due to 0-ms timeout at lib/ovsdb-cs.c:943 (87% CPU usage)
2026-06-22T12:55:47.779Z|00134|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (87% CPU usage)
2026-06-22T12:55:47.781Z|00135|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (87% CPU usage)
2026-06-22T12:55:47.813Z|00136|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:38716<->10.4.3.109:6642) at lib/stream-ssl.c:842 (87% CPU usage)
2026-06-22T12:55:47.814Z|00137|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:38716<->10.4.3.109:6642) at lib/stream-ssl.c:842 (87% CPU usage)
2026-06-22T12:55:47.815Z|00138|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:38716<->10.4.3.109:6642) at lib/stream-ssl.c:842 (87% CPU usage)
2026-06-22T12:55:47.837Z|00139|binding|INFO|Claiming lport 27f8682e-c828-44c8-af7b-ca345c97a5af for this chassis.
2026-06-22T12:55:47.837Z|00140|binding|INFO|27f8682e-c828-44c8-af7b-ca345c97a5af: Claiming fa:16:3e:9a:dc:e1 10.1.0.3
2026-06-22T12:55:47.865Z|00141|binding|INFO|Setting lport 27f8682e-c828-44c8-af7b-ca345c97a5af ovn-installed in OVS
2026-06-22T12:55:47.866Z|00142|binding|INFO|Setting lport 27f8682e-c828-44c8-af7b-ca345c97a5af up in Southbound
2026-06-22T12:55:48.634Z|00143|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:55:49.028Z|00144|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:55:52.578Z|00145|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:55:52.578Z|00146|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:55:52.578Z|00147|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:55:53.343Z|00148|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:55:53.344Z|00149|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:55:53.344Z|00150|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:55:54.759Z|00151|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:55:54.759Z|00152|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:55:54.759Z|00153|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:55:56.079Z|00004|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:a0:1e:08 10.1.0.13
2026-06-22T12:55:56.091Z|00005|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:a0:1e:08 10.1.0.13
2026-06-22T12:55:57.386Z|00154|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:55:57.386Z|00155|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:55:57.386Z|00156|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:55:57.705Z|00157|binding|INFO|Claiming lport 54e713c7-cfe3-47b1-8cac-1d8324fa83b4 for this chassis.
2026-06-22T12:55:57.705Z|00158|binding|INFO|54e713c7-cfe3-47b1-8cac-1d8324fa83b4: Claiming fa:16:3e:d7:e3:a3 10.1.0.9
2026-06-22T12:55:57.762Z|00159|binding|INFO|Setting lport 54e713c7-cfe3-47b1-8cac-1d8324fa83b4 ovn-installed in OVS
2026-06-22T12:55:57.762Z|00160|binding|INFO|Setting lport 54e713c7-cfe3-47b1-8cac-1d8324fa83b4 up in Southbound
2026-06-22T12:55:58.179Z|00161|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:55:59.919Z|00162|binding|INFO|Claiming lport cr-lrp-5fbcf9aa-0d56-4a17-b9b1-f585d79b3298 for this chassis.
2026-06-22T12:55:59.919Z|00163|binding|INFO|cr-lrp-5fbcf9aa-0d56-4a17-b9b1-f585d79b3298: Claiming fa:16:3e:ca:5b:e8 172.24.5.42/24 2001:db8::2cb/64
2026-06-22T12:55:59.928Z|00164|binding|INFO|Setting lport cr-lrp-5fbcf9aa-0d56-4a17-b9b1-f585d79b3298 up in Southbound
2026-06-22T12:56:00.107Z|00165|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:56:00.107Z|00166|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:56:00.107Z|00167|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:56:00.107Z|00168|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:56:02.921Z|00169|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:56:02.921Z|00170|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:56:02.921Z|00171|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:56:02.921Z|00172|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:56:03.909Z|00173|binding|INFO|Claiming lport cr-lrp-61d070ad-ce24-4b01-8c0f-d813ccb6003e for this chassis.
2026-06-22T12:56:03.909Z|00174|binding|INFO|cr-lrp-61d070ad-ce24-4b01-8c0f-d813ccb6003e: Claiming fa:16:3e:76:2e:63 172.24.5.180/24 2001:db8::318/64
2026-06-22T12:56:03.921Z|00175|binding|INFO|Setting lport cr-lrp-61d070ad-ce24-4b01-8c0f-d813ccb6003e up in Southbound
2026-06-22T12:56:06.345Z|00176|binding|INFO|Releasing lport aba451cf-ecff-49c5-b6f5-4b3bfdccb36a from this chassis (sb_readonly=0)
2026-06-22T12:56:06.345Z|00177|binding|INFO|Setting lport aba451cf-ecff-49c5-b6f5-4b3bfdccb36a down in Southbound
2026-06-22T12:56:06.346Z|00178|binding|INFO|Removing iface tapaba451cf-ec ovn-installed in OVS
2026-06-22T12:56:06.456Z|00179|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:56:06.456Z|00180|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:56:06.456Z|00181|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:56:06.688Z|00182|binding|INFO|Claiming lport aba451cf-ecff-49c5-b6f5-4b3bfdccb36a for this chassis.
2026-06-22T12:56:06.688Z|00183|binding|INFO|aba451cf-ecff-49c5-b6f5-4b3bfdccb36a: Claiming fa:16:3e:a0:1e:08 10.1.0.13
2026-06-22T12:56:06.720Z|00184|binding|INFO|Releasing lport aba451cf-ecff-49c5-b6f5-4b3bfdccb36a from this chassis (sb_readonly=0)
2026-06-22T12:56:07.293Z|00185|binding|INFO|Releasing lport 7d668f2f-e8ed-454a-9f1c-d0b16ccd7334 from this chassis (sb_readonly=0)
2026-06-22T12:56:12.193Z|00006|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:9a:dc:e1 10.1.0.3
2026-06-22T12:56:12.202Z|00007|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:9a:dc:e1 10.1.0.3
2026-06-22T12:56:17.398Z|00008|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:d7:e3:a3 10.1.0.9
2026-06-22T12:56:17.412Z|00009|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:d7:e3:a3 10.1.0.9
2026-06-22T12:56:20.193Z|00186|binding|INFO|Claiming lport cr-lrp-4561afc6-25c2-4caf-a161-b497c6352820 for this chassis.
2026-06-22T12:56:20.193Z|00187|binding|INFO|cr-lrp-4561afc6-25c2-4caf-a161-b497c6352820: Claiming fa:16:3e:41:e7:1a 172.24.5.99/24 2001:db8::38c/64
2026-06-22T12:56:20.205Z|00188|binding|INFO|Setting lport cr-lrp-4561afc6-25c2-4caf-a161-b497c6352820 up in Southbound
2026-06-22T12:56:20.805Z|00010|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:3c:d9:27 10.1.0.6
2026-06-22T12:56:20.826Z|00011|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:3c:d9:27 10.1.0.6
2026-06-22T12:56:21.054Z|00189|binding|INFO|Claiming lport cr-lrp-b85a9a30-acf1-49d9-9f89-653100faff95 for this chassis.
2026-06-22T12:56:21.054Z|00190|binding|INFO|cr-lrp-b85a9a30-acf1-49d9-9f89-653100faff95: Claiming fa:16:3e:4f:b6:a5 172.24.5.162/24 2001:db8::2b3/64
2026-06-22T12:56:21.065Z|00191|binding|INFO|Setting lport cr-lrp-b85a9a30-acf1-49d9-9f89-653100faff95 up in Southbound
2026-06-22T12:56:24.472Z|00192|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:56:24.472Z|00193|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:56:24.472Z|00194|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:56:25.430Z|00195|binding|INFO|Claiming lport cr-lrp-b4399e21-5d37-451d-a066-7e1c391fe61a for this chassis.
2026-06-22T12:56:25.430Z|00196|binding|INFO|cr-lrp-b4399e21-5d37-451d-a066-7e1c391fe61a: Claiming fa:16:3e:8d:50:17 172.24.5.137/24 2001:db8::3ac/64
2026-06-22T12:56:25.441Z|00197|binding|INFO|Setting lport cr-lrp-b4399e21-5d37-451d-a066-7e1c391fe61a up in Southbound
2026-06-22T12:56:36.346Z|00198|binding|INFO|Claiming lport 678e84a0-eff1-44e7-af5d-86c4b1660645 for this chassis.
2026-06-22T12:56:36.346Z|00199|binding|INFO|678e84a0-eff1-44e7-af5d-86c4b1660645: Claiming fa:16:3e:24:2a:1d 10.1.0.14
2026-06-22T12:56:36.378Z|00200|binding|INFO|Setting lport 678e84a0-eff1-44e7-af5d-86c4b1660645 ovn-installed in OVS
2026-06-22T12:56:37.082Z|00201|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:56:37.085Z|00202|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:56:37.088Z|00203|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:56:37.124Z|00204|binding|INFO|Setting lport 678e84a0-eff1-44e7-af5d-86c4b1660645 up in Southbound
2026-06-22T12:56:37.783Z|00205|binding|INFO|Releasing lport 90a2a866-d26e-46b3-8043-a242973213aa from this chassis (sb_readonly=0)
2026-06-22T12:56:42.134Z|00206|binding|INFO|Claiming lport 49331f7e-b8a1-4da2-bf54-1d389f684b3c for this chassis.
2026-06-22T12:56:42.134Z|00207|binding|INFO|49331f7e-b8a1-4da2-bf54-1d389f684b3c: Claiming fa:16:3e:1b:9c:6a 192.168.233.252
2026-06-22T12:56:42.207Z|00208|binding|INFO|Setting lport 49331f7e-b8a1-4da2-bf54-1d389f684b3c ovn-installed in OVS
2026-06-22T12:56:42.208Z|00209|binding|INFO|Setting lport 49331f7e-b8a1-4da2-bf54-1d389f684b3c up in Southbound
2026-06-22T12:56:42.699Z|00210|binding|INFO|Releasing lport fcc58fec-7eb8-4184-af09-ed54c0fa19b6 from this chassis (sb_readonly=0)
2026-06-22T12:56:43.950Z|00211|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:56:43.950Z|00212|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:56:43.950Z|00213|binding|INFO|Releasing lport fcc58fec-7eb8-4184-af09-ed54c0fa19b6 from this chassis (sb_readonly=0)
2026-06-22T12:56:43.950Z|00214|binding|INFO|Releasing lport 90a2a866-d26e-46b3-8043-a242973213aa from this chassis (sb_readonly=0)
2026-06-22T12:56:43.950Z|00215|binding|INFO|Releasing lport 745cd3cb-6221-402f-907a-88dd5d0e767b from this chassis (sb_readonly=0)
2026-06-22T12:56:44.753Z|00216|binding|INFO|Claiming lport cr-lrp-66294d2c-5adb-4a0b-9c6c-7176749109d1 for this chassis.
2026-06-22T12:56:44.755Z|00217|binding|INFO|cr-lrp-66294d2c-5adb-4a0b-9c6c-7176749109d1: Claiming fa:16:3e:2c:6a:5b 172.24.5.200/24 2001:db8::3c4/64
2026-06-22T12:56:44.765Z|00218|binding|INFO|Setting lport cr-lrp-66294d2c-5adb-4a0b-9c6c-7176749109d1 up in Southbound
2026-06-22T12:56:45.828Z|00219|binding|INFO|Releasing lport 27f8682e-c828-44c8-af7b-ca345c97a5af from this chassis (sb_readonly=0)
2026-06-22T12:56:45.828Z|00220|binding|INFO|Setting lport 27f8682e-c828-44c8-af7b-ca345c97a5af down in Southbound
2026-06-22T12:56:45.831Z|00221|binding|INFO|Removing iface tap27f8682e-c8 ovn-installed in OVS
2026-06-22T12:57:00.589Z|00222|reconnect|ERR|ssl:10.4.3.109:6642: no response to inactivity probe after 6.26 seconds, disconnecting
2026-06-22T12:57:00.589Z|00223|reconnect|INFO|ssl:10.4.3.109:6642: connection dropped
2026-06-22T12:57:00.590Z|00224|main|INFO|OVNSB commit failed, force recompute next time.
2026-06-22T12:57:01.591Z|00225|reconnect|INFO|ssl:10.4.3.109:6642: connecting...
2026-06-22T12:57:01.595Z|00226|reconnect|INFO|ssl:10.4.3.109:6642: connected
2026-06-22T12:57:01.647Z|00227|binding|INFO|Claiming lport cr-lrp-309e46f1-3eae-4aad-9db2-d45d962cda15 for this chassis.
2026-06-22T12:57:01.647Z|00228|binding|INFO|cr-lrp-309e46f1-3eae-4aad-9db2-d45d962cda15: Claiming fa:16:3e:d0:34:c3 172.24.5.36/24 2001:db8::1fb/64
2026-06-22T12:57:01.647Z|00229|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:57:01.647Z|00230|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:57:01.647Z|00231|binding|INFO|Releasing lport fcc58fec-7eb8-4184-af09-ed54c0fa19b6 from this chassis (sb_readonly=0)
2026-06-22T12:57:01.647Z|00232|binding|INFO|Releasing lport 90a2a866-d26e-46b3-8043-a242973213aa from this chassis (sb_readonly=0)
2026-06-22T12:57:01.685Z|00233|binding|INFO|Setting lport cr-lrp-309e46f1-3eae-4aad-9db2-d45d962cda15 up in Southbound
2026-06-22T12:57:04.039Z|00012|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:24:2a:1d 10.1.0.14
2026-06-22T12:57:04.053Z|00013|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:24:2a:1d 10.1.0.14
2026-06-22T12:57:15.549Z|00234|reconnect|ERR|ssl:10.4.3.109:6642: no response to inactivity probe after 5.46 seconds, disconnecting
2026-06-22T12:57:15.556Z|00235|reconnect|INFO|ssl:10.4.3.109:6642: connection dropped
2026-06-22T12:57:15.651Z|00236|main|INFO|OVNSB commit failed, force recompute next time.
2026-06-22T12:57:16.681Z|00237|reconnect|INFO|ssl:10.4.3.109:6642: connecting...
2026-06-22T12:57:17.754Z|00238|reconnect|INFO|ssl:10.4.3.109:6642: connection attempt timed out
2026-06-22T12:57:17.775Z|00239|reconnect|INFO|ssl:10.4.3.109:6642: waiting 2 seconds before reconnect
2026-06-22T12:57:19.758Z|00240|reconnect|INFO|ssl:10.4.3.109:6642: connecting...
2026-06-22T12:57:19.876Z|00241|reconnect|INFO|ssl:10.4.3.109:6642: connected
2026-06-22T12:57:20.066Z|00242|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:57:20.066Z|00243|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:57:20.066Z|00244|binding|INFO|Releasing lport fcc58fec-7eb8-4184-af09-ed54c0fa19b6 from this chassis (sb_readonly=0)
2026-06-22T12:57:20.066Z|00245|binding|INFO|Releasing lport 90a2a866-d26e-46b3-8043-a242973213aa from this chassis (sb_readonly=0)
2026-06-22T12:57:20.130Z|00246|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T12:57:20.130Z|00247|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T12:57:20.130Z|00248|binding|INFO|Releasing lport fcc58fec-7eb8-4184-af09-ed54c0fa19b6 from this chassis (sb_readonly=0)
2026-06-22T12:57:20.130Z|00249|binding|INFO|Releasing lport 90a2a866-d26e-46b3-8043-a242973213aa from this chassis (sb_readonly=0)
2026-06-22T12:57:45.931Z|00250|timeval|WARN|Unreasonably long 1837ms poll interval (8ms user, 1704ms system)
2026-06-22T12:57:45.931Z|00251|timeval|WARN|faults: 57 minor, 293 major
2026-06-22T12:57:45.931Z|00252|timeval|WARN|disk: 68800 reads, 0 writes
2026-06-22T12:57:45.931Z|00253|timeval|WARN|context switches: 293 voluntary, 1503 involuntary
2026-06-22T12:57:45.931Z|00254|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=c947faab:
2026-06-22T12:57:45.931Z|00255|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:57:45.931Z|00256|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:57:45.931Z|00257|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:57:45.931Z|00258|coverage|INFO|vconn_sent                 0.0/sec    38.583/sec        4.4375/sec   total: 15975
2026-06-22T12:57:45.931Z|00259|coverage|INFO|vconn_received             0.0/sec     1.983/sec        0.2033/sec   total: 732
2026-06-22T12:57:45.931Z|00260|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T12:57:45.931Z|00261|coverage|INFO|util_xalloc              658.4/sec 20584.667/sec     1559.0808/sec   total: 5617602
2026-06-22T12:57:45.931Z|00262|coverage|INFO|long_poll_interval         0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T12:57:45.931Z|00263|coverage|INFO|stream_open                0.0/sec     0.050/sec        0.0028/sec   total: 10
2026-06-22T12:57:45.931Z|00264|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T12:57:45.931Z|00265|coverage|INFO|seq_change                 5.0/sec    19.750/sec        2.0333/sec   total: 7346
2026-06-22T12:57:45.931Z|00266|coverage|INFO|rconn_sent                 0.0/sec    38.583/sec        4.4364/sec   total: 15971
2026-06-22T12:57:45.931Z|00267|coverage|INFO|rconn_queued               0.0/sec    38.583/sec        4.4364/sec   total: 15971
2026-06-22T12:57:45.931Z|00268|coverage|INFO|poll_zero_timeout          0.4/sec     0.583/sec        0.0486/sec   total: 178
2026-06-22T12:57:45.931Z|00269|coverage|INFO|poll_create_node          14.6/sec    59.817/sec        6.0925/sec   total: 22019
2026-06-22T12:57:45.931Z|00270|coverage|INFO|txn_try_again              0.0/sec     0.033/sec        0.0006/sec   total: 2
2026-06-22T12:57:45.931Z|00271|coverage|INFO|txn_success                0.0/sec     0.400/sec        0.0378/sec   total: 136
2026-06-22T12:57:45.931Z|00272|coverage|INFO|txn_incomplete             0.0/sec     0.583/sec        0.0614/sec   total: 221
2026-06-22T12:57:45.931Z|00273|coverage|INFO|txn_unchanged              1.6/sec     5.450/sec        0.5844/sec   total: 2116
2026-06-22T12:57:45.931Z|00274|coverage|INFO|hmap_reserve               4.0/sec    15.400/sec        0.6547/sec   total: 2387
2026-06-22T12:57:45.931Z|00275|coverage|INFO|hmap_expand               14.0/sec   373.800/sec       26.0097/sec   total: 93741
2026-06-22T12:57:45.931Z|00276|coverage|INFO|hmap_pathological          0.0/sec     2.083/sec        0.2536/sec   total: 913
2026-06-22T12:57:45.931Z|00277|coverage|INFO|miniflow_malloc            0.0/sec   569.967/sec       51.3467/sec   total: 184848
2026-06-22T12:57:45.931Z|00278|coverage|INFO|flow_extract               0.0/sec     0.083/sec        0.0036/sec   total: 13
2026-06-22T12:57:45.931Z|00279|coverage|INFO|physical_run               0.0/sec     0.217/sec        0.0308/sec   total: 111
2026-06-22T12:57:45.931Z|00280|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.083/sec        0.0036/sec   total: 13
2026-06-22T12:57:45.931Z|00281|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.050/sec        0.0008/sec   total: 3
2026-06-22T12:57:45.931Z|00282|coverage|INFO|lflow_conj_free            0.0/sec     0.050/sec        0.0036/sec   total: 13
2026-06-22T12:57:45.931Z|00283|coverage|INFO|lflow_conj_alloc           0.0/sec     0.417/sec        0.0183/sec   total: 66
2026-06-22T12:57:45.931Z|00284|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:57:45.931Z|00285|coverage|INFO|lflow_cache_delete         0.0/sec     7.533/sec        1.6503/sec   total: 5941
2026-06-22T12:57:45.931Z|00286|coverage|INFO|lflow_cache_miss           0.0/sec    32.017/sec        3.8019/sec   total: 13687
2026-06-22T12:57:45.931Z|00287|coverage|INFO|lflow_cache_hit            0.0/sec   290.117/sec       24.6906/sec   total: 88886
2026-06-22T12:57:45.931Z|00288|coverage|INFO|lflow_cache_add            0.0/sec    10.250/sec        1.9956/sec   total: 7184
2026-06-22T12:57:45.932Z|00289|coverage|INFO|lflow_cache_free_matches   0.0/sec     5.667/sec        1.3319/sec   total: 4795
2026-06-22T12:57:45.932Z|00290|coverage|INFO|lflow_cache_free_expr      0.0/sec     1.867/sec        0.3183/sec   total: 1146
2026-06-22T12:57:45.932Z|00291|coverage|INFO|lflow_cache_add_matches    0.0/sec     6.100/sec        1.4350/sec   total: 5166
2026-06-22T12:57:45.932Z|00292|coverage|INFO|lflow_cache_add_expr       0.0/sec     4.150/sec        0.5606/sec   total: 2018
2026-06-22T12:57:45.932Z|00293|coverage|INFO|consider_logical_flow      0.0/sec   114.000/sec        7.8283/sec   total: 28182
2026-06-22T12:57:45.932Z|00294|coverage|INFO|lflow_run                  0.0/sec     0.083/sec        0.0053/sec   total: 19
2026-06-22T12:57:45.932Z|00295|coverage|INFO|111 events never hit
2026-06-22T12:57:46.181Z|00296|poll_loop|INFO|Dropped 28 log messages in last 118 seconds (most recently, 116 seconds ago) due to excessive rate
2026-06-22T12:57:46.181Z|00297|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (78% CPU usage)
2026-06-22T12:57:46.182Z|00298|binding|INFO|Claiming lport cr-lrp-99223d42-e7bc-4e16-bdd9-635dbc7fc189 for this chassis.
2026-06-22T12:57:46.182Z|00299|binding|INFO|cr-lrp-99223d42-e7bc-4e16-bdd9-635dbc7fc189: Claiming fa:16:3e:69:4b:21 172.24.5.253/24 2001:db8::2fa/64
2026-06-22T12:57:46.197Z|00300|binding|INFO|Setting lport cr-lrp-99223d42-e7bc-4e16-bdd9-635dbc7fc189 up in Southbound
2026-06-22T12:57:46.198Z|00301|poll_loop|INFO|wakeup due to 0-ms timeout at lib/ovsdb-cs.c:943 (78% CPU usage)
2026-06-22T12:57:46.205Z|00302|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (78% CPU usage)
2026-06-22T12:57:46.211Z|00303|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (78% CPU usage)
2026-06-22T12:57:46.242Z|00304|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (78% CPU usage)
2026-06-22T12:57:46.243Z|00305|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (78% CPU usage)
2026-06-22T12:57:46.249Z|00306|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (78% CPU usage)
2026-06-22T12:57:55.353Z|00307|binding|INFO|Releasing lport 49331f7e-b8a1-4da2-bf54-1d389f684b3c from this chassis (sb_readonly=0)
2026-06-22T12:57:55.438Z|00308|binding|INFO|Setting lport 49331f7e-b8a1-4da2-bf54-1d389f684b3c down in Southbound
2026-06-22T12:58:08.628Z|00014|timeval(ovn_pinctrl0)|WARN|Unreasonably long 5059ms poll interval (0ms user, 3377ms system)
2026-06-22T12:58:10.328Z|00015|timeval(ovn_pinctrl0)|WARN|faults: 66 minor, 574 major
2026-06-22T12:58:12.408Z|00004|timeval(ovn_statctrl3)|WARN|Unreasonably long 11602ms poll interval (3ms user, 7629ms system)
2026-06-22T12:58:12.019Z|00016|timeval(ovn_pinctrl0)|WARN|disk: 153752 reads, 0 writes
2026-06-22T12:58:13.028Z|00005|timeval(ovn_statctrl3)|WARN|faults: 192 minor, 1730 major
2026-06-22T12:58:13.304Z|00017|timeval(ovn_pinctrl0)|WARN|context switches: 591 voluntary, 2999 involuntary
2026-06-22T12:58:14.021Z|00006|timeval(ovn_statctrl3)|WARN|disk: 445144 reads, 0 writes
2026-06-22T12:58:14.583Z|00007|timeval(ovn_statctrl3)|WARN|context switches: 1773 voluntary, 5736 involuntary
2026-06-22T12:58:17.777Z|00008|coverage(ovn_statctrl3)|INFO|Skipping details of duplicate event coverage for hash=4cc28929
2026-06-22T12:58:40.709Z|00018|coverage(ovn_pinctrl0)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=4cc28929:
2026-06-22T12:58:40.715Z|00019|coverage(ovn_pinctrl0)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:58:40.715Z|00020|coverage(ovn_pinctrl0)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:58:40.715Z|00021|coverage(ovn_pinctrl0)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:58:40.715Z|00022|coverage(ovn_pinctrl0)|INFO|vconn_sent                 0.2/sec    15.017/sec        4.4400/sec   total: 15984
2026-06-22T12:58:40.715Z|00023|coverage(ovn_pinctrl0)|INFO|vconn_received             0.0/sec     0.650/sec        0.2047/sec   total: 740
2026-06-22T12:58:40.715Z|00024|coverage(ovn_pinctrl0)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T12:58:40.715Z|00025|coverage(ovn_pinctrl0)|INFO|util_xalloc                2.0/sec 11932.750/sec     1560.5558/sec   total: 5618022
2026-06-22T12:58:40.715Z|00026|coverage(ovn_pinctrl0)|INFO|long_poll_interval         0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T12:58:40.715Z|00027|coverage(ovn_pinctrl0)|INFO|stream_open                0.0/sec     0.050/sec        0.0028/sec   total: 10
2026-06-22T12:58:40.715Z|00028|coverage(ovn_pinctrl0)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T12:58:40.715Z|00029|coverage(ovn_pinctrl0)|INFO|seq_change                 0.2/sec     9.383/sec        2.0628/sec   total: 7428
2026-06-22T12:58:40.715Z|00030|coverage(ovn_pinctrl0)|INFO|rconn_sent                 0.2/sec    15.017/sec        4.4389/sec   total: 15980
2026-06-22T12:58:40.715Z|00031|coverage(ovn_pinctrl0)|INFO|rconn_queued               0.2/sec    15.017/sec        4.4389/sec   total: 15980
2026-06-22T12:58:40.715Z|00032|coverage(ovn_pinctrl0)|INFO|poll_zero_timeout          0.0/sec     0.467/sec        0.0494/sec   total: 178
2026-06-22T12:58:40.715Z|00033|coverage(ovn_pinctrl0)|INFO|poll_create_node           0.8/sec    28.100/sec        6.1669/sec   total: 22205
2026-06-22T12:58:40.715Z|00034|coverage(ovn_pinctrl0)|INFO|txn_try_again              0.0/sec     0.033/sec        0.0006/sec   total: 2
2026-06-22T12:58:40.715Z|00035|coverage(ovn_pinctrl0)|INFO|txn_success                0.0/sec     0.117/sec        0.0378/sec   total: 136
2026-06-22T12:58:40.715Z|00036|coverage(ovn_pinctrl0)|INFO|txn_incomplete             0.0/sec     0.167/sec        0.0614/sec   total: 221
2026-06-22T12:58:40.715Z|00037|coverage(ovn_pinctrl0)|INFO|txn_unchanged              0.0/sec     2.400/sec        0.5878/sec   total: 2116
2026-06-22T12:58:40.715Z|00038|coverage(ovn_pinctrl0)|INFO|hmap_reserve               0.0/sec     7.000/sec        0.6631/sec   total: 2387
2026-06-22T12:58:40.715Z|00039|coverage(ovn_pinctrl0)|INFO|hmap_expand                0.0/sec   226.983/sec       26.0392/sec   total: 93741
2026-06-22T12:58:40.715Z|00040|coverage(ovn_pinctrl0)|INFO|hmap_pathological          0.0/sec     1.183/sec        0.2536/sec   total: 913
2026-06-22T12:58:40.715Z|00041|coverage(ovn_pinctrl0)|INFO|miniflow_malloc            0.0/sec   281.650/sec       51.3467/sec   total: 184848
2026-06-22T12:58:40.715Z|00042|coverage(ovn_pinctrl0)|INFO|flow_extract               0.0/sec     0.067/sec        0.0039/sec   total: 14
2026-06-22T12:58:40.715Z|00043|coverage(ovn_pinctrl0)|INFO|physical_run               0.0/sec     0.083/sec        0.0308/sec   total: 111
2026-06-22T12:58:40.715Z|00044|coverage(ovn_pinctrl0)|INFO|pinctrl_total_pin_pkts     0.0/sec     0.067/sec        0.0039/sec   total: 14
2026-06-22T12:58:40.715Z|00045|coverage(ovn_pinctrl0)|INFO|pinctrl_notify_main_thread   0.0/sec     0.033/sec        0.0011/sec   total: 4
2026-06-22T12:58:40.715Z|00046|coverage(ovn_pinctrl0)|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0036/sec   total: 13
2026-06-22T12:58:40.715Z|00047|coverage(ovn_pinctrl0)|INFO|lflow_conj_alloc           0.0/sec     0.200/sec        0.0183/sec   total: 66
2026-06-22T12:58:40.715Z|00048|coverage(ovn_pinctrl0)|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:58:40.715Z|00049|coverage(ovn_pinctrl0)|INFO|lflow_cache_delete         0.0/sec     1.150/sec        1.6503/sec   total: 5941
2026-06-22T12:58:40.715Z|00050|coverage(ovn_pinctrl0)|INFO|lflow_cache_miss           0.0/sec    12.617/sec        3.8019/sec   total: 13687
2026-06-22T12:58:40.715Z|00051|coverage(ovn_pinctrl0)|INFO|lflow_cache_hit            0.0/sec   152.650/sec       24.6906/sec   total: 88886
2026-06-22T12:58:40.715Z|00052|coverage(ovn_pinctrl0)|INFO|lflow_cache_add            0.0/sec     3.633/sec        1.9956/sec   total: 7184
2026-06-22T12:58:40.715Z|00053|coverage(ovn_pinctrl0)|INFO|lflow_cache_free_matches   0.0/sec     1.017/sec        1.3319/sec   total: 4795
2026-06-22T12:58:40.715Z|00054|coverage(ovn_pinctrl0)|INFO|lflow_cache_free_expr      0.0/sec     0.133/sec        0.3183/sec   total: 1146
2026-06-22T12:58:40.715Z|00055|coverage(ovn_pinctrl0)|INFO|lflow_cache_add_matches    0.0/sec     1.417/sec        1.4350/sec   total: 5166
2026-06-22T12:58:40.715Z|00056|coverage(ovn_pinctrl0)|INFO|lflow_cache_add_expr       0.0/sec     2.217/sec        0.5606/sec   total: 2018
2026-06-22T12:58:40.715Z|00057|coverage(ovn_pinctrl0)|INFO|consider_logical_flow      0.0/sec    66.533/sec        7.8283/sec   total: 28182
2026-06-22T12:58:40.715Z|00058|coverage(ovn_pinctrl0)|INFO|lflow_run                  0.0/sec     0.050/sec        0.0053/sec   total: 19
2026-06-22T12:58:40.715Z|00059|coverage(ovn_pinctrl0)|INFO|111 events never hit
2026-06-22T12:58:40.715Z|00060|poll_loop(ovn_pinctrl0)|INFO|wakeup due to 0-ms timeout at controller/pinctrl.c:4064 (59% CPU usage)
2026-06-22T12:58:40.722Z|00309|inc_proc_eng|INFO|node: logical_flow_output, handler for input port_groups took 45113ms
2026-06-22T12:58:40.724Z|00310|binding|INFO|Removing iface tap49331f7e-b8 ovn-installed in OVS
2026-06-22T12:58:40.727Z|00311|timeval|WARN|Unreasonably long 49679ms poll interval (69ms user, 29884ms system)
2026-06-22T12:58:40.727Z|00312|timeval|WARN|faults: 1059 minor, 8783 major
2026-06-22T12:58:40.727Z|00313|timeval|WARN|disk: 2294288 reads, 24 writes
2026-06-22T12:58:40.727Z|00314|timeval|WARN|context switches: 8898 voluntary, 21897 involuntary
2026-06-22T12:58:40.728Z|00315|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=a5272664:
2026-06-22T12:58:40.728Z|00316|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:58:40.728Z|00317|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:58:40.728Z|00318|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:58:40.728Z|00319|coverage|INFO|vconn_sent                 0.2/sec     0.167/sec        4.4403/sec   total: 16227
2026-06-22T12:58:40.728Z|00320|coverage|INFO|vconn_received             0.6/sec     0.133/sec        0.2056/sec   total: 749
2026-06-22T12:58:40.728Z|00321|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T12:58:40.728Z|00322|coverage|INFO|util_xalloc                4.4/sec   200.367/sec     1560.5925/sec   total: 5688756
2026-06-22T12:58:40.728Z|00323|coverage|INFO|long_poll_interval         0.2/sec     0.017/sec        0.0006/sec   total: 3
2026-06-22T12:58:40.728Z|00324|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0028/sec   total: 10
2026-06-22T12:58:40.728Z|00325|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T12:58:40.728Z|00326|coverage|INFO|seq_change                 0.6/sec     2.633/sec        2.0636/sec   total: 7445
2026-06-22T12:58:40.728Z|00327|coverage|INFO|rconn_sent                 0.2/sec     0.167/sec        4.4392/sec   total: 16223
2026-06-22T12:58:40.728Z|00328|coverage|INFO|rconn_queued               0.2/sec     0.167/sec        4.4392/sec   total: 16223
2026-06-22T12:58:40.728Z|00329|coverage|INFO|poll_zero_timeout          0.0/sec     0.117/sec        0.0494/sec   total: 180
2026-06-22T12:58:40.728Z|00330|coverage|INFO|poll_create_node           0.6/sec     7.000/sec        6.1692/sec   total: 22307
2026-06-22T12:58:40.728Z|00331|coverage|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:58:40.728Z|00332|coverage|INFO|txn_success                0.0/sec     0.000/sec        0.0378/sec   total: 138
2026-06-22T12:58:40.728Z|00333|coverage|INFO|txn_incomplete             0.0/sec     0.000/sec        0.0614/sec   total: 226
2026-06-22T12:58:40.728Z|00334|coverage|INFO|txn_unchanged              0.0/sec     0.467/sec        0.5878/sec   total: 2135
2026-06-22T12:58:40.728Z|00335|coverage|INFO|hmap_reserve               0.0/sec     1.167/sec        0.6631/sec   total: 2447
2026-06-22T12:58:40.728Z|00336|coverage|INFO|hmap_expand                0.0/sec     4.100/sec       26.0392/sec   total: 94741
2026-06-22T12:58:40.728Z|00337|coverage|INFO|hmap_pathological          0.0/sec     0.000/sec        0.2536/sec   total: 925
2026-06-22T12:58:40.728Z|00338|coverage|INFO|miniflow_malloc            0.0/sec     0.000/sec       51.3467/sec   total: 186567
2026-06-22T12:58:40.728Z|00339|coverage|INFO|flow_extract               0.0/sec     0.017/sec        0.0039/sec   total: 14
2026-06-22T12:58:40.728Z|00340|coverage|INFO|physical_run               0.0/sec     0.000/sec        0.0308/sec   total: 112
2026-06-22T12:58:40.728Z|00341|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.017/sec        0.0039/sec   total: 14
2026-06-22T12:58:40.728Z|00342|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.017/sec        0.0011/sec   total: 4
2026-06-22T12:58:40.728Z|00343|coverage|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0036/sec   total: 14
2026-06-22T12:58:40.728Z|00344|coverage|INFO|lflow_conj_alloc           0.0/sec     0.000/sec        0.0183/sec   total: 66
2026-06-22T12:58:40.728Z|00345|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:58:40.728Z|00346|coverage|INFO|lflow_cache_delete         0.0/sec     0.000/sec        1.6503/sec   total: 6018
2026-06-22T12:58:40.728Z|00347|coverage|INFO|lflow_cache_miss           0.0/sec     0.000/sec        3.8019/sec   total: 13843
2026-06-22T12:58:40.728Z|00348|coverage|INFO|lflow_cache_hit            0.0/sec     0.000/sec       24.6906/sec   total: 89729
2026-06-22T12:58:40.728Z|00349|coverage|INFO|lflow_cache_add            0.0/sec     0.000/sec        1.9956/sec   total: 7290
2026-06-22T12:58:40.728Z|00350|coverage|INFO|lflow_cache_free_matches   0.0/sec     0.000/sec        1.3319/sec   total: 4862
2026-06-22T12:58:40.728Z|00351|coverage|INFO|lflow_cache_free_expr      0.0/sec     0.000/sec        0.3183/sec   total: 1156
2026-06-22T12:58:40.728Z|00352|coverage|INFO|lflow_cache_add_matches    0.0/sec     0.000/sec        1.4350/sec   total: 5239
2026-06-22T12:58:40.728Z|00353|coverage|INFO|lflow_cache_add_expr       0.0/sec     0.000/sec        0.5606/sec   total: 2051
2026-06-22T12:58:40.728Z|00354|coverage|INFO|consider_logical_flow      0.0/sec     0.000/sec        7.8283/sec   total: 28307
2026-06-22T12:58:40.728Z|00355|coverage|INFO|lflow_run                  0.0/sec     0.000/sec        0.0053/sec   total: 19
2026-06-22T12:58:40.728Z|00356|coverage|INFO|111 events never hit
2026-06-22T12:58:40.728Z|00357|poll_loop|INFO|wakeup due to [POLLIN] on fd 30 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (60% CPU usage)
2026-06-22T12:58:40.733Z|00358|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (60% CPU usage)
2026-06-22T12:58:40.734Z|00359|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (60% CPU usage)
2026-06-22T12:58:40.735Z|00360|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (60% CPU usage)
2026-06-22T12:58:40.738Z|00361|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (60% CPU usage)
2026-06-22T12:58:40.740Z|00362|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (60% CPU usage)
2026-06-22T12:58:40.852Z|00061|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (59% CPU usage)
2026-06-22T12:58:40.852Z|00363|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (60% CPU usage)
2026-06-22T12:58:40.856Z|00364|poll_loop|INFO|wakeup due to 0-ms timeout at lib/ovsdb-cs.c:943 (60% CPU usage)
2026-06-22T12:58:40.874Z|00365|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (60% CPU usage)
2026-06-22T12:58:40.875Z|00366|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (60% CPU usage)
2026-06-22T12:58:54.340Z|00367|binding|INFO|Claiming lport 5e5ad158-6591-4562-b711-91eb11abeb12 for this chassis.
2026-06-22T12:58:54.341Z|00368|binding|INFO|5e5ad158-6591-4562-b711-91eb11abeb12: Claiming fa:16:3e:23:e6:a5 10.1.0.11
2026-06-22T12:58:54.400Z|00369|binding|INFO|Setting lport 5e5ad158-6591-4562-b711-91eb11abeb12 ovn-installed in OVS
2026-06-22T12:58:54.401Z|00370|binding|INFO|Setting lport 5e5ad158-6591-4562-b711-91eb11abeb12 up in Southbound
2026-06-22T12:58:55.602Z|00371|binding|INFO|Releasing lport 36a3e1c4-0c2d-4ae0-9e31-aff818e100e7 from this chassis (sb_readonly=0)
2026-06-22T12:59:00.736Z|00009|timeval(ovn_statctrl3)|WARN|Unreasonably long 3871ms poll interval (0ms user, 1734ms system)
2026-06-22T12:59:00.736Z|00010|timeval(ovn_statctrl3)|WARN|faults: 9 minor, 69 major
2026-06-22T12:59:00.736Z|00011|timeval(ovn_statctrl3)|WARN|disk: 17472 reads, 0 writes
2026-06-22T12:59:00.736Z|00012|timeval(ovn_statctrl3)|WARN|context switches: 70 voluntary, 1884 involuntary
2026-06-22T12:59:00.736Z|00013|coverage(ovn_statctrl3)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=9df7042a:
2026-06-22T12:59:00.736Z|00014|coverage(ovn_statctrl3)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:59:00.736Z|00015|coverage(ovn_statctrl3)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:59:00.736Z|00016|coverage(ovn_statctrl3)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T12:59:00.736Z|00017|coverage(ovn_statctrl3)|INFO|vconn_sent                27.0/sec     9.033/sec        4.5889/sec   total: 16520
2026-06-22T12:59:00.736Z|00018|coverage(ovn_statctrl3)|INFO|vconn_received             1.4/sec     0.717/sec        0.2156/sec   total: 776
2026-06-22T12:59:00.736Z|00019|coverage(ovn_statctrl3)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T12:59:00.736Z|00020|coverage(ovn_statctrl3)|INFO|util_xalloc              7190.2/sec  2670.800/sec     1604.9769/sec   total: 5777917
2026-06-22T12:59:00.736Z|00021|coverage(ovn_statctrl3)|INFO|long_poll_interval         0.2/sec     0.067/sec        0.0014/sec   total: 5
2026-06-22T12:59:00.736Z|00022|coverage(ovn_statctrl3)|INFO|stream_open                0.0/sec     0.000/sec        0.0028/sec   total: 10
2026-06-22T12:59:00.736Z|00023|coverage(ovn_statctrl3)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T12:59:00.736Z|00024|coverage(ovn_statctrl3)|INFO|seq_change                11.6/sec     5.317/sec        2.1314/sec   total: 7673
2026-06-22T12:59:00.736Z|00025|coverage(ovn_statctrl3)|INFO|rconn_sent                27.0/sec     9.033/sec        4.5878/sec   total: 16516
2026-06-22T12:59:00.736Z|00026|coverage(ovn_statctrl3)|INFO|rconn_queued              27.0/sec     9.033/sec        4.5878/sec   total: 16516
2026-06-22T12:59:00.736Z|00027|coverage(ovn_statctrl3)|INFO|poll_zero_timeout          0.4/sec     0.133/sec        0.0517/sec   total: 186
2026-06-22T12:59:00.736Z|00028|coverage(ovn_statctrl3)|INFO|poll_create_node          36.8/sec    15.567/sec        6.3836/sec   total: 22981
2026-06-22T12:59:00.736Z|00029|coverage(ovn_statctrl3)|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:59:00.736Z|00030|coverage(ovn_statctrl3)|INFO|txn_success                0.6/sec     0.183/sec        0.0408/sec   total: 147
2026-06-22T12:59:00.736Z|00031|coverage(ovn_statctrl3)|INFO|txn_incomplete             1.0/sec     0.267/sec        0.0658/sec   total: 237
2026-06-22T12:59:00.736Z|00032|coverage(ovn_statctrl3)|INFO|txn_unchanged              3.4/sec     1.300/sec        0.6094/sec   total: 2194
2026-06-22T12:59:00.736Z|00033|coverage(ovn_statctrl3)|INFO|hmap_reserve              10.6/sec     3.917/sec        0.7283/sec   total: 2622
2026-06-22T12:59:00.736Z|00034|coverage(ovn_statctrl3)|INFO|hmap_expand               87.8/sec    36.483/sec       26.6472/sec   total: 95930
2026-06-22T12:59:00.736Z|00035|coverage(ovn_statctrl3)|INFO|hmap_pathological          1.2/sec     0.433/sec        0.2608/sec   total: 939
2026-06-22T12:59:00.736Z|00036|coverage(ovn_statctrl3)|INFO|miniflow_malloc          318.6/sec    81.933/sec       52.7122/sec   total: 189764
2026-06-22T12:59:00.736Z|00037|coverage(ovn_statctrl3)|INFO|flow_extract               0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T12:59:00.736Z|00038|coverage(ovn_statctrl3)|INFO|physical_run               0.2/sec     0.050/sec        0.0317/sec   total: 114
2026-06-22T12:59:00.736Z|00039|coverage(ovn_statctrl3)|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T12:59:00.736Z|00040|coverage(ovn_statctrl3)|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T12:59:00.736Z|00041|coverage(ovn_statctrl3)|INFO|lflow_conj_free            0.2/sec     0.033/sec        0.0042/sec   total: 15
2026-06-22T12:59:00.736Z|00042|coverage(ovn_statctrl3)|INFO|lflow_conj_alloc           0.2/sec     0.033/sec        0.0189/sec   total: 68
2026-06-22T12:59:00.736Z|00043|coverage(ovn_statctrl3)|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T12:59:00.736Z|00044|coverage(ovn_statctrl3)|INFO|lflow_cache_delete         7.0/sec     2.467/sec        1.6914/sec   total: 6089
2026-06-22T12:59:00.736Z|00045|coverage(ovn_statctrl3)|INFO|lflow_cache_miss          27.2/sec     7.150/sec        3.9211/sec   total: 14116
2026-06-22T12:59:00.736Z|00046|coverage(ovn_statctrl3)|INFO|lflow_cache_hit          110.6/sec    32.533/sec       25.2328/sec   total: 90838
2026-06-22T12:59:00.736Z|00047|coverage(ovn_statctrl3)|INFO|lflow_cache_add            7.8/sec     3.067/sec        2.0467/sec   total: 7368
2026-06-22T12:59:00.736Z|00048|coverage(ovn_statctrl3)|INFO|lflow_cache_free_matches   6.8/sec     2.250/sec        1.3694/sec   total: 4930
2026-06-22T12:59:00.736Z|00049|coverage(ovn_statctrl3)|INFO|lflow_cache_free_expr      0.2/sec     0.217/sec        0.3219/sec   total: 1159
2026-06-22T12:59:00.736Z|00050|coverage(ovn_statctrl3)|INFO|lflow_cache_add_matches    7.0/sec     2.367/sec        1.4744/sec   total: 5308
2026-06-22T12:59:00.736Z|00051|coverage(ovn_statctrl3)|INFO|lflow_cache_add_expr       1.0/sec     0.700/sec        0.5722/sec   total: 2060
2026-06-22T12:59:00.736Z|00052|coverage(ovn_statctrl3)|INFO|consider_logical_flow     12.0/sec     4.117/sec        7.8969/sec   total: 28429
2026-06-22T12:59:00.736Z|00053|coverage(ovn_statctrl3)|INFO|lflow_run                  0.0/sec     0.000/sec        0.0053/sec   total: 19
2026-06-22T12:59:00.736Z|00054|coverage(ovn_statctrl3)|INFO|111 events never hit
2026-06-22T12:59:00.739Z|00372|timeval|WARN|Unreasonably long 5142ms poll interval (6ms user, 2795ms system)
2026-06-22T12:59:00.739Z|00373|timeval|WARN|faults: 82 minor, 298 major
2026-06-22T12:59:00.739Z|00374|timeval|WARN|disk: 63304 reads, 8 writes
2026-06-22T12:59:00.739Z|00375|timeval|WARN|context switches: 299 voluntary, 2794 involuntary
2026-06-22T12:59:28.505Z|00376|timeval|WARN|Unreasonably long 2723ms poll interval (0ms user, 991ms system)
2026-06-22T12:59:28.506Z|00377|timeval|WARN|faults: 22 minor, 73 major
2026-06-22T12:59:28.506Z|00378|timeval|WARN|disk: 15624 reads, 0 writes
2026-06-22T12:59:28.506Z|00379|timeval|WARN|context switches: 74 voluntary, 917 involuntary
2026-06-22T12:59:42.664Z|00062|timeval(ovn_pinctrl0)|WARN|Unreasonably long 1330ms poll interval (0ms user, 17ms system)
2026-06-22T12:59:42.665Z|00063|timeval(ovn_pinctrl0)|WARN|faults: 8 minor, 19 major
2026-06-22T12:59:42.665Z|00064|timeval(ovn_pinctrl0)|WARN|disk: 4504 reads, 0 writes
2026-06-22T12:59:42.665Z|00065|timeval(ovn_pinctrl0)|WARN|context switches: 21 voluntary, 14 involuntary
2026-06-22T13:00:01.313Z|00055|timeval(ovn_statctrl3)|WARN|Unreasonably long 3536ms poll interval (0ms user, 1690ms system)
2026-06-22T13:00:01.313Z|00056|timeval(ovn_statctrl3)|WARN|faults: 10 minor, 83 major
2026-06-22T13:00:01.313Z|00057|timeval(ovn_statctrl3)|WARN|disk: 19656 reads, 0 writes
2026-06-22T13:00:01.313Z|00058|timeval(ovn_statctrl3)|WARN|context switches: 82 voluntary, 1649 involuntary
2026-06-22T13:00:01.313Z|00059|coverage(ovn_statctrl3)|INFO|Dropped 3 log messages in last 60 seconds (most recently, 18 seconds ago) due to excessive rate
2026-06-22T13:00:01.313Z|00060|coverage(ovn_statctrl3)|INFO|Skipping details of duplicate event coverage for hash=9df7042a
2026-06-22T13:00:01.315Z|00380|memory_trim|INFO|Detected inactivity (last active 42140 ms ago): trimming memory
2026-06-22T13:00:01.316Z|00381|timeval|WARN|Unreasonably long 10779ms poll interval (0ms user, 8339ms system)
2026-06-22T13:00:01.316Z|00382|timeval|WARN|faults: 34 minor, 386 major
2026-06-22T13:00:01.316Z|00383|timeval|WARN|disk: 99784 reads, 0 writes
2026-06-22T13:00:01.316Z|00384|timeval|WARN|context switches: 390 voluntary, 7560 involuntary
2026-06-22T13:00:01.316Z|00385|poll_loop|INFO|Dropped 4 log messages in last 80 seconds (most recently, 77 seconds ago) due to excessive rate
2026-06-22T13:00:01.316Z|00386|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (81% CPU usage)
2026-06-22T13:00:01.318Z|00387|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (81% CPU usage)
2026-06-22T13:00:01.322Z|00388|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (81% CPU usage)
2026-06-22T13:01:17.100Z|00389|timeval|WARN|Unreasonably long 19413ms poll interval (0ms user, 18214ms system)
2026-06-22T13:01:17.100Z|00390|timeval|WARN|faults: 233 minor, 2408 major
2026-06-22T13:01:17.100Z|00391|timeval|WARN|disk: 619880 reads, 0 writes
2026-06-22T13:01:17.100Z|00392|timeval|WARN|context switches: 2447 voluntary, 14516 involuntary
2026-06-22T13:01:17.100Z|00393|coverage|INFO|Dropped 1 log messages in last 76 seconds (most recently, 76 seconds ago) due to excessive rate
2026-06-22T13:01:17.100Z|00394|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=95f972bd:
2026-06-22T13:01:17.100Z|00395|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:01:17.100Z|00396|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:01:17.100Z|00397|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:01:17.100Z|00398|coverage|INFO|vconn_sent                 2.0/sec     1.483/sec        4.6792/sec   total: 16845
2026-06-22T13:01:17.100Z|00399|coverage|INFO|vconn_received             0.6/sec     0.150/sec        0.2233/sec   total: 807
2026-06-22T13:01:17.100Z|00400|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:01:17.100Z|00401|coverage|INFO|util_xalloc              562.4/sec   793.967/sec     1638.3897/sec   total: 5899968
2026-06-22T13:01:17.100Z|00402|coverage|INFO|long_poll_interval         0.2/sec     0.033/sec        0.0031/sec   total: 11
2026-06-22T13:01:17.100Z|00403|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0028/sec   total: 10
2026-06-22T13:01:17.100Z|00404|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:01:17.100Z|00405|coverage|INFO|seq_change                 2.4/sec     3.717/sec        2.2747/sec   total: 8191
2026-06-22T13:01:17.100Z|00406|coverage|INFO|rconn_sent                 2.0/sec     1.483/sec        4.6781/sec   total: 16841
2026-06-22T13:01:17.100Z|00407|coverage|INFO|rconn_queued               2.0/sec     1.483/sec        4.6781/sec   total: 16841
2026-06-22T13:01:17.100Z|00408|coverage|INFO|poll_zero_timeout          0.4/sec     0.283/sec        0.0617/sec   total: 222
2026-06-22T13:01:17.100Z|00409|coverage|INFO|poll_create_node           6.4/sec    11.617/sec        6.8122/sec   total: 24540
2026-06-22T13:01:17.100Z|00410|coverage|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:01:17.100Z|00411|coverage|INFO|txn_success                0.4/sec     0.033/sec        0.0422/sec   total: 152
2026-06-22T13:01:17.100Z|00412|coverage|INFO|txn_incomplete             0.2/sec     0.050/sec        0.0681/sec   total: 246
2026-06-22T13:01:17.100Z|00413|coverage|INFO|txn_unchanged              1.2/sec     1.383/sec        0.6556/sec   total: 2363
2026-06-22T13:01:17.100Z|00414|coverage|INFO|hmap_reserve               2.0/sec     3.583/sec        0.8492/sec   total: 3067
2026-06-22T13:01:17.100Z|00415|coverage|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:01:17.100Z|00416|coverage|INFO|hmap_expand                9.6/sec    15.250/sec       27.2267/sec   total: 98054
2026-06-22T13:01:17.100Z|00417|coverage|INFO|hmap_pathological          0.0/sec     0.050/sec        0.2631/sec   total: 947
2026-06-22T13:01:17.100Z|00418|coverage|INFO|miniflow_malloc            0.4/sec     1.200/sec       53.1731/sec   total: 191423
2026-06-22T13:01:17.100Z|00419|coverage|INFO|flow_extract               0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:01:17.100Z|00420|coverage|INFO|physical_run               0.0/sec     0.000/sec        0.0325/sec   total: 117
2026-06-22T13:01:17.100Z|00421|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:01:17.100Z|00422|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:01:17.100Z|00423|coverage|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0042/sec   total: 15
2026-06-22T13:01:17.100Z|00424|coverage|INFO|lflow_conj_alloc           0.0/sec     0.000/sec        0.0189/sec   total: 68
2026-06-22T13:01:17.100Z|00425|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:01:17.100Z|00426|coverage|INFO|lflow_cache_delete         0.8/sec     0.850/sec        1.7086/sec   total: 6151
2026-06-22T13:01:17.100Z|00427|coverage|INFO|lflow_cache_miss           0.8/sec     0.950/sec        3.9558/sec   total: 14241
2026-06-22T13:01:17.100Z|00428|coverage|INFO|lflow_cache_hit            0.8/sec     1.333/sec       25.2950/sec   total: 91062
2026-06-22T13:01:17.100Z|00429|coverage|INFO|lflow_cache_add            0.0/sec     0.150/sec        2.0650/sec   total: 7434
2026-06-22T13:01:17.100Z|00430|coverage|INFO|lflow_cache_free_matches   0.6/sec     0.167/sec        1.3736/sec   total: 4945
2026-06-22T13:01:17.100Z|00431|coverage|INFO|lflow_cache_free_expr      0.8/sec     0.683/sec        0.3350/sec   total: 1206
2026-06-22T13:01:17.100Z|00432|coverage|INFO|lflow_cache_add_matches    0.0/sec     0.067/sec        1.4789/sec   total: 5324
2026-06-22T13:01:17.100Z|00433|coverage|INFO|lflow_cache_add_expr       0.0/sec     0.083/sec        0.5861/sec   total: 2110
2026-06-22T13:01:17.100Z|00434|coverage|INFO|consider_logical_flow      0.0/sec     0.150/sec        7.9164/sec   total: 28499
2026-06-22T13:01:17.100Z|00435|coverage|INFO|lflow_run                  0.0/sec     0.000/sec        0.0053/sec   total: 19
2026-06-22T13:01:17.100Z|00436|coverage|INFO|110 events never hit
2026-06-22T13:01:17.100Z|00437|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (93% CPU usage)
2026-06-22T13:01:17.106Z|00438|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (93% CPU usage)
2026-06-22T13:01:17.108Z|00439|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (93% CPU usage)
2026-06-22T13:01:17.108Z|00440|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (93% CPU usage)
2026-06-22T13:01:19.620Z|00441|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (93% CPU usage)
2026-06-22T13:01:36.382Z|00442|timeval|WARN|Unreasonably long 2315ms poll interval (0ms user, 1508ms system)
2026-06-22T13:01:36.382Z|00443|timeval|WARN|faults: 21 minor, 118 major
2026-06-22T13:01:36.382Z|00444|timeval|WARN|disk: 29688 reads, 0 writes
2026-06-22T13:01:36.382Z|00445|timeval|WARN|context switches: 118 voluntary, 1398 involuntary
2026-06-22T13:01:48.442Z|00446|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T13:01:48.442Z|00447|binding|INFO|Releasing lport 36a3e1c4-0c2d-4ae0-9e31-aff818e100e7 from this chassis (sb_readonly=0)
2026-06-22T13:01:48.442Z|00448|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T13:01:48.442Z|00449|binding|INFO|Releasing lport 90a2a866-d26e-46b3-8043-a242973213aa from this chassis (sb_readonly=0)
2026-06-22T13:01:50.760Z|00450|binding|INFO|Releasing lport a3c60e14-4034-4303-ae96-88c9dfadcbb5 from this chassis (sb_readonly=0)
2026-06-22T13:01:50.761Z|00451|binding|INFO|Releasing lport 36a3e1c4-0c2d-4ae0-9e31-aff818e100e7 from this chassis (sb_readonly=0)
2026-06-22T13:01:50.761Z|00452|binding|INFO|Releasing lport 75706485-cf9a-4638-b189-e5b5b08d7ec2 from this chassis (sb_readonly=0)
2026-06-22T13:01:50.761Z|00453|binding|INFO|Releasing lport 90a2a866-d26e-46b3-8043-a242973213aa from this chassis (sb_readonly=0)
2026-06-22T13:02:28.032Z|00454|memory_trim|INFO|Detected inactivity (last active 30007 ms ago): trimming memory
2026-06-22T13:03:29.925Z|00001|timeval(stopwatch2)|WARN|Unreasonably long 3073ms poll interval (0ms user, 2621ms system)
2026-06-22T13:03:35.087Z|00002|timeval(stopwatch2)|WARN|faults: 21 minor, 216 major
2026-06-22T13:03:43.100Z|00003|timeval(stopwatch2)|WARN|disk: 58528 reads, 0 writes
2026-06-22T13:03:43.100Z|00004|timeval(stopwatch2)|WARN|context switches: 225 voluntary, 2366 involuntary
2026-06-22T13:03:43.100Z|00005|coverage(stopwatch2)|INFO|Dropped 1 log messages in last 126 seconds (most recently, 126 seconds ago) due to excessive rate
2026-06-22T13:03:43.101Z|00006|coverage(stopwatch2)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=dcf02db2:
2026-06-22T13:03:43.101Z|00007|coverage(stopwatch2)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:03:43.101Z|00008|coverage(stopwatch2)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:03:43.101Z|00009|coverage(stopwatch2)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:03:43.101Z|00010|coverage(stopwatch2)|INFO|vconn_sent                 0.2/sec     0.100/sec        4.9308/sec   total: 17751
2026-06-22T13:03:43.101Z|00011|coverage(stopwatch2)|INFO|vconn_received             0.2/sec     0.100/sec        0.2331/sec   total: 839
2026-06-22T13:03:43.101Z|00012|coverage(stopwatch2)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:03:43.101Z|00013|coverage(stopwatch2)|INFO|util_xalloc              298.4/sec   596.217/sec     1739.4756/sec   total: 6262112
2026-06-22T13:03:43.101Z|00014|coverage(stopwatch2)|INFO|long_poll_interval         0.0/sec     0.000/sec        0.0036/sec   total: 13
2026-06-22T13:03:43.101Z|00015|coverage(stopwatch2)|INFO|stream_open                0.0/sec     0.000/sec        0.0028/sec   total: 10
2026-06-22T13:03:43.101Z|00016|coverage(stopwatch2)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:03:43.101Z|00017|coverage(stopwatch2)|INFO|seq_change                 2.0/sec     4.250/sec        2.4578/sec   total: 8848
2026-06-22T13:03:43.101Z|00018|coverage(stopwatch2)|INFO|rconn_sent                 0.2/sec     0.100/sec        4.9297/sec   total: 17747
2026-06-22T13:03:43.101Z|00019|coverage(stopwatch2)|INFO|rconn_queued               0.2/sec     0.100/sec        4.9297/sec   total: 17747
2026-06-22T13:03:43.101Z|00020|coverage(stopwatch2)|INFO|poll_zero_timeout          0.2/sec     0.367/sec        0.0733/sec   total: 264
2026-06-22T13:03:43.101Z|00021|coverage(stopwatch2)|INFO|poll_create_node           6.6/sec    13.183/sec        7.3636/sec   total: 26509
2026-06-22T13:03:43.101Z|00022|coverage(stopwatch2)|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:03:43.101Z|00023|coverage(stopwatch2)|INFO|txn_success                0.0/sec     0.000/sec        0.0436/sec   total: 157
2026-06-22T13:03:43.101Z|00024|coverage(stopwatch2)|INFO|txn_incomplete             0.0/sec     0.000/sec        0.0700/sec   total: 252
2026-06-22T13:03:43.101Z|00025|coverage(stopwatch2)|INFO|txn_unchanged              0.8/sec     1.600/sec        0.7158/sec   total: 2577
2026-06-22T13:03:43.101Z|00026|coverage(stopwatch2)|INFO|hmap_reserve               2.0/sec     4.000/sec        1.0047/sec   total: 3617
2026-06-22T13:03:43.101Z|00027|coverage(stopwatch2)|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:03:43.101Z|00028|coverage(stopwatch2)|INFO|hmap_expand                7.0/sec    13.967/sec       29.2147/sec   total: 105173
2026-06-22T13:03:43.101Z|00029|coverage(stopwatch2)|INFO|hmap_pathological          0.0/sec     0.000/sec        0.2683/sec   total: 966
2026-06-22T13:03:43.101Z|00030|coverage(stopwatch2)|INFO|miniflow_malloc            0.0/sec     0.000/sec       56.0156/sec   total: 201656
2026-06-22T13:03:43.101Z|00031|coverage(stopwatch2)|INFO|flow_extract               0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:03:43.101Z|00032|coverage(stopwatch2)|INFO|physical_run               0.0/sec     0.000/sec        0.0331/sec   total: 119
2026-06-22T13:03:43.101Z|00033|coverage(stopwatch2)|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:03:43.101Z|00034|coverage(stopwatch2)|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:03:43.101Z|00035|coverage(stopwatch2)|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0042/sec   total: 15
2026-06-22T13:03:43.101Z|00036|coverage(stopwatch2)|INFO|lflow_conj_alloc           0.0/sec     0.000/sec        0.0211/sec   total: 76
2026-06-22T13:03:43.101Z|00037|coverage(stopwatch2)|INFO|lflow_cache_trim           0.0/sec     0.017/sec        0.0011/sec   total: 4
2026-06-22T13:03:43.101Z|00038|coverage(stopwatch2)|INFO|lflow_cache_delete         0.0/sec     0.000/sec        1.7547/sec   total: 6317
2026-06-22T13:03:43.101Z|00039|coverage(stopwatch2)|INFO|lflow_cache_miss           0.0/sec     0.000/sec        4.0881/sec   total: 14717
2026-06-22T13:03:43.101Z|00040|coverage(stopwatch2)|INFO|lflow_cache_hit            0.0/sec     0.000/sec       26.9281/sec   total: 96941
2026-06-22T13:03:43.101Z|00041|coverage(stopwatch2)|INFO|lflow_cache_add            0.0/sec     0.000/sec        2.0683/sec   total: 7446
2026-06-22T13:03:43.101Z|00042|coverage(stopwatch2)|INFO|lflow_cache_free_matches   0.0/sec     0.000/sec        1.3828/sec   total: 4978
2026-06-22T13:03:43.101Z|00043|coverage(stopwatch2)|INFO|lflow_cache_free_expr      0.0/sec     0.000/sec        0.3719/sec   total: 1339
2026-06-22T13:03:43.101Z|00044|coverage(stopwatch2)|INFO|lflow_cache_add_matches    0.0/sec     0.000/sec        1.4800/sec   total: 5328
2026-06-22T13:03:43.101Z|00045|coverage(stopwatch2)|INFO|lflow_cache_add_expr       0.0/sec     0.000/sec        0.5883/sec   total: 2118
2026-06-22T13:03:43.101Z|00046|coverage(stopwatch2)|INFO|consider_logical_flow      0.0/sec     0.000/sec        8.6200/sec   total: 31032
2026-06-22T13:03:43.101Z|00047|coverage(stopwatch2)|INFO|lflow_run                  0.0/sec     0.000/sec        0.0058/sec   total: 21
2026-06-22T13:03:43.101Z|00048|coverage(stopwatch2)|INFO|110 events never hit
2026-06-22T13:03:43.101Z|00049|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.102Z|00050|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.102Z|00051|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.103Z|00052|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.104Z|00455|timeval|WARN|Unreasonably long 23988ms poll interval (10ms user, 16953ms system)
2026-06-22T13:03:43.104Z|00456|timeval|WARN|faults: 267 minor, 3466 major
2026-06-22T13:03:43.104Z|00457|timeval|WARN|disk: 922248 reads, 0 writes
2026-06-22T13:03:43.104Z|00458|timeval|WARN|context switches: 3517 voluntary, 13666 involuntary
2026-06-22T13:03:43.104Z|00459|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=31ac41f1:
2026-06-22T13:03:43.104Z|00460|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:03:43.104Z|00461|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:03:43.104Z|00462|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:03:43.104Z|00463|coverage|INFO|vconn_sent                 0.0/sec     0.100/sec        4.9308/sec   total: 17751
2026-06-22T13:03:43.104Z|00464|coverage|INFO|vconn_received             0.0/sec     0.100/sec        0.2331/sec   total: 839
2026-06-22T13:03:43.104Z|00465|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:03:43.104Z|00466|coverage|INFO|util_xalloc               11.4/sec   450.150/sec     1739.5069/sec   total: 6265137
2026-06-22T13:03:43.104Z|00467|coverage|INFO|long_poll_interval         0.2/sec     0.017/sec        0.0039/sec   total: 14
2026-06-22T13:03:43.104Z|00468|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0028/sec   total: 10
2026-06-22T13:03:43.104Z|00469|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:03:43.104Z|00470|coverage|INFO|seq_change                 0.2/sec     3.483/sec        2.4581/sec   total: 8853
2026-06-22T13:03:43.104Z|00471|coverage|INFO|rconn_sent                 0.0/sec     0.100/sec        4.9297/sec   total: 17747
2026-06-22T13:03:43.104Z|00472|coverage|INFO|rconn_queued               0.0/sec     0.100/sec        4.9297/sec   total: 17747
2026-06-22T13:03:43.104Z|00473|coverage|INFO|poll_zero_timeout          0.0/sec     0.283/sec        0.0733/sec   total: 266
2026-06-22T13:03:43.104Z|00474|coverage|INFO|poll_create_node           0.2/sec    10.500/sec        7.3642/sec   total: 26542
2026-06-22T13:03:43.104Z|00475|coverage|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:03:43.104Z|00476|coverage|INFO|txn_success                0.0/sec     0.000/sec        0.0436/sec   total: 157
2026-06-22T13:03:43.104Z|00477|coverage|INFO|txn_incomplete             0.0/sec     0.000/sec        0.0700/sec   total: 252
2026-06-22T13:03:43.104Z|00478|coverage|INFO|txn_unchanged              0.0/sec     1.200/sec        0.7158/sec   total: 2585
2026-06-22T13:03:43.104Z|00479|coverage|INFO|hmap_reserve               0.0/sec     3.000/sec        1.0047/sec   total: 3637
2026-06-22T13:03:43.104Z|00480|coverage|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:03:43.104Z|00481|coverage|INFO|hmap_expand                0.0/sec    10.467/sec       29.2147/sec   total: 105243
2026-06-22T13:03:43.104Z|00482|coverage|INFO|hmap_pathological          0.0/sec     0.000/sec        0.2683/sec   total: 966
2026-06-22T13:03:43.104Z|00483|coverage|INFO|miniflow_malloc            0.0/sec     0.000/sec       56.0156/sec   total: 201656
2026-06-22T13:03:43.104Z|00484|coverage|INFO|flow_extract               0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:03:43.104Z|00485|coverage|INFO|physical_run               0.0/sec     0.000/sec        0.0331/sec   total: 119
2026-06-22T13:03:43.104Z|00486|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:03:43.104Z|00487|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:03:43.104Z|00488|coverage|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0042/sec   total: 15
2026-06-22T13:03:43.104Z|00489|coverage|INFO|lflow_conj_alloc           0.0/sec     0.000/sec        0.0211/sec   total: 76
2026-06-22T13:03:43.104Z|00490|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:03:43.104Z|00491|coverage|INFO|lflow_cache_delete         0.0/sec     0.000/sec        1.7547/sec   total: 6317
2026-06-22T13:03:43.104Z|00492|coverage|INFO|lflow_cache_miss           0.0/sec     0.000/sec        4.0881/sec   total: 14717
2026-06-22T13:03:43.104Z|00493|coverage|INFO|lflow_cache_hit            0.0/sec     0.000/sec       26.9281/sec   total: 96941
2026-06-22T13:03:43.104Z|00494|coverage|INFO|lflow_cache_add            0.0/sec     0.000/sec        2.0683/sec   total: 7446
2026-06-22T13:03:43.104Z|00495|coverage|INFO|lflow_cache_free_matches   0.0/sec     0.000/sec        1.3828/sec   total: 4978
2026-06-22T13:03:43.104Z|00496|coverage|INFO|lflow_cache_free_expr      0.0/sec     0.000/sec        0.3719/sec   total: 1339
2026-06-22T13:03:43.104Z|00497|coverage|INFO|lflow_cache_add_matches    0.0/sec     0.000/sec        1.4800/sec   total: 5328
2026-06-22T13:03:43.104Z|00498|coverage|INFO|lflow_cache_add_expr       0.0/sec     0.000/sec        0.5883/sec   total: 2118
2026-06-22T13:03:43.104Z|00499|coverage|INFO|consider_logical_flow      0.0/sec     0.000/sec        8.6200/sec   total: 31032
2026-06-22T13:03:43.104Z|00500|coverage|INFO|lflow_run                  0.0/sec     0.000/sec        0.0058/sec   total: 21
2026-06-22T13:03:43.104Z|00501|coverage|INFO|110 events never hit
2026-06-22T13:03:43.104Z|00502|poll_loop|INFO|wakeup due to [POLLIN] on fd 30 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (70% CPU usage)
2026-06-22T13:03:43.105Z|00053|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.105Z|00054|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.105Z|00055|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.106Z|00503|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (70% CPU usage)
2026-06-22T13:03:43.106Z|00056|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.106Z|00057|poll_loop(stopwatch2)|INFO|wakeup due to [POLLIN] on fd 24 (FIFO pipe:[165756]) at lib/stopwatch.c:456 (68% CPU usage)
2026-06-22T13:03:43.106Z|00504|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (70% CPU usage)
2026-06-22T13:04:01.666Z|00061|timeval(ovn_statctrl3)|WARN|Unreasonably long 13828ms poll interval (0ms user, 9479ms system)
2026-06-22T13:04:01.667Z|00062|timeval(ovn_statctrl3)|WARN|faults: 54 minor, 593 major
2026-06-22T13:04:01.667Z|00063|timeval(ovn_statctrl3)|WARN|disk: 156616 reads, 0 writes
2026-06-22T13:04:01.667Z|00064|timeval(ovn_statctrl3)|WARN|context switches: 614 voluntary, 9049 involuntary
2026-06-22T13:04:01.667Z|00065|coverage(ovn_statctrl3)|INFO|Skipping details of duplicate event coverage for hash=31ac41f1
2026-06-22T13:04:01.667Z|00066|poll_loop(ovn_statctrl3)|INFO|Dropped 5 log messages in last 19 seconds (most recently, 19 seconds ago) due to excessive rate
2026-06-22T13:04:01.667Z|00067|poll_loop(ovn_statctrl3)|INFO|wakeup due to [POLLIN] on fd 36 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (70% CPU usage)
2026-06-22T13:04:01.670Z|00505|timeval|WARN|Unreasonably long 13146ms poll interval (2ms user, 9299ms system)
2026-06-22T13:04:01.671Z|00506|timeval|WARN|faults: 68 minor, 663 major
2026-06-22T13:04:01.671Z|00507|timeval|WARN|disk: 170984 reads, 0 writes
2026-06-22T13:04:01.671Z|00508|timeval|WARN|context switches: 675 voluntary, 9089 involuntary
2026-06-22T13:04:01.671Z|00509|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (72% CPU usage)
2026-06-22T13:04:01.680Z|00510|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (72% CPU usage)
2026-06-22T13:04:01.712Z|00511|binding|INFO|Releasing lport 5e5ad158-6591-4562-b711-91eb11abeb12 from this chassis (sb_readonly=0)
2026-06-22T13:04:01.712Z|00512|binding|INFO|Setting lport 5e5ad158-6591-4562-b711-91eb11abeb12 down in Southbound
2026-06-22T13:04:01.714Z|00513|binding|INFO|Removing iface tap5e5ad158-65 ovn-installed in OVS
2026-06-22T13:04:12.766Z|00514|timeval|WARN|Unreasonably long 5105ms poll interval (2ms user, 4814ms system)
2026-06-22T13:04:12.766Z|00515|timeval|WARN|faults: 30 minor, 271 major
2026-06-22T13:04:12.766Z|00516|timeval|WARN|disk: 69872 reads, 0 writes
2026-06-22T13:04:12.766Z|00517|timeval|WARN|context switches: 274 voluntary, 4175 involuntary
2026-06-22T13:04:12.766Z|00518|poll_loop|INFO|Dropped 16 log messages in last 11 seconds (most recently, 11 seconds ago) due to excessive rate
2026-06-22T13:04:12.766Z|00519|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (100% CPU usage)
2026-06-22T13:04:21.374Z|00520|timeval|WARN|Unreasonably long 2500ms poll interval (1ms user, 2282ms system)
2026-06-22T13:04:21.374Z|00521|timeval|WARN|faults: 23 minor, 136 major
2026-06-22T13:04:21.374Z|00522|timeval|WARN|disk: 34320 reads, 0 writes
2026-06-22T13:04:21.374Z|00523|timeval|WARN|context switches: 137 voluntary, 1987 involuntary
2026-06-22T13:04:31.737Z|00524|memory_trim|INFO|Detected inactivity (last active 30005 ms ago): trimming memory
2026-06-22T13:04:51.861Z|00068|timeval(ovn_statctrl3)|WARN|Unreasonably long 5081ms poll interval (0ms user, 2592ms system)
2026-06-22T13:04:51.861Z|00069|timeval(ovn_statctrl3)|WARN|faults: 13 minor, 126 major
2026-06-22T13:04:51.861Z|00070|timeval(ovn_statctrl3)|WARN|disk: 31184 reads, 0 writes
2026-06-22T13:04:51.861Z|00071|timeval(ovn_statctrl3)|WARN|context switches: 124 voluntary, 2917 involuntary
2026-06-22T13:04:51.861Z|00072|coverage(ovn_statctrl3)|INFO|Dropped 3 log messages in last 50 seconds (most recently, 30 seconds ago) due to excessive rate
2026-06-22T13:04:51.861Z|00073|coverage(ovn_statctrl3)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=1993a81f:
2026-06-22T13:04:51.861Z|00074|coverage(ovn_statctrl3)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:04:51.861Z|00075|coverage(ovn_statctrl3)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:04:51.861Z|00076|coverage(ovn_statctrl3)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:04:51.862Z|00077|coverage(ovn_statctrl3)|INFO|vconn_sent                 0.8/sec     1.433/sec        4.9547/sec   total: 17837
2026-06-22T13:04:51.862Z|00078|coverage(ovn_statctrl3)|INFO|vconn_received             0.8/sec     0.400/sec        0.2397/sec   total: 863
2026-06-22T13:04:51.862Z|00079|coverage(ovn_statctrl3)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:04:51.862Z|00080|coverage(ovn_statctrl3)|INFO|util_xalloc              1121.2/sec   796.033/sec     1752.7583/sec   total: 6309930
2026-06-22T13:04:51.862Z|00081|coverage(ovn_statctrl3)|INFO|long_poll_interval         0.2/sec     0.100/sec        0.0053/sec   total: 19
2026-06-22T13:04:51.862Z|00082|coverage(ovn_statctrl3)|INFO|stream_open                0.0/sec     0.000/sec        0.0028/sec   total: 10
2026-06-22T13:04:51.862Z|00083|coverage(ovn_statctrl3)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:04:51.862Z|00084|coverage(ovn_statctrl3)|INFO|seq_change                 5.6/sec     4.933/sec        2.5400/sec   total: 9144
2026-06-22T13:04:51.862Z|00085|coverage(ovn_statctrl3)|INFO|rconn_sent                 0.8/sec     1.433/sec        4.9536/sec   total: 17833
2026-06-22T13:04:51.862Z|00086|coverage(ovn_statctrl3)|INFO|rconn_queued               0.8/sec     1.433/sec        4.9536/sec   total: 17833
2026-06-22T13:04:51.862Z|00087|coverage(ovn_statctrl3)|INFO|poll_zero_timeout          0.6/sec     0.300/sec        0.0783/sec   total: 282
2026-06-22T13:04:51.862Z|00088|coverage(ovn_statctrl3)|INFO|poll_create_node          20.8/sec    14.967/sec        7.6133/sec   total: 27408
2026-06-22T13:04:51.862Z|00089|coverage(ovn_statctrl3)|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:04:51.862Z|00090|coverage(ovn_statctrl3)|INFO|txn_success                0.0/sec     0.067/sec        0.0447/sec   total: 161
2026-06-22T13:04:51.862Z|00091|coverage(ovn_statctrl3)|INFO|txn_incomplete             0.0/sec     0.083/sec        0.0714/sec   total: 257
2026-06-22T13:04:51.862Z|00092|coverage(ovn_statctrl3)|INFO|txn_unchanged              3.2/sec     1.617/sec        0.7428/sec   total: 2674
2026-06-22T13:04:51.862Z|00093|coverage(ovn_statctrl3)|INFO|hmap_reserve               6.4/sec     3.800/sec        1.0681/sec   total: 3845
2026-06-22T13:04:51.862Z|00094|coverage(ovn_statctrl3)|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:04:51.862Z|00095|coverage(ovn_statctrl3)|INFO|hmap_expand               28.0/sec    17.400/sec       29.5047/sec   total: 106217
2026-06-22T13:04:51.862Z|00096|coverage(ovn_statctrl3)|INFO|hmap_pathological          0.0/sec     0.000/sec        0.2683/sec   total: 966
2026-06-22T13:04:51.862Z|00097|coverage(ovn_statctrl3)|INFO|miniflow_malloc            0.0/sec     0.817/sec       56.0292/sec   total: 201705
2026-06-22T13:04:51.862Z|00098|coverage(ovn_statctrl3)|INFO|flow_extract               0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:04:51.862Z|00099|coverage(ovn_statctrl3)|INFO|physical_run               0.0/sec     0.000/sec        0.0331/sec   total: 119
2026-06-22T13:04:51.862Z|00100|coverage(ovn_statctrl3)|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:04:51.862Z|00101|coverage(ovn_statctrl3)|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:04:51.862Z|00102|coverage(ovn_statctrl3)|INFO|lflow_conj_free            0.0/sec     0.017/sec        0.0044/sec   total: 16
2026-06-22T13:04:51.862Z|00103|coverage(ovn_statctrl3)|INFO|lflow_conj_alloc           0.0/sec     0.000/sec        0.0211/sec   total: 76
2026-06-22T13:04:51.862Z|00104|coverage(ovn_statctrl3)|INFO|lflow_cache_trim           0.0/sec     0.017/sec        0.0014/sec   total: 5
2026-06-22T13:04:51.862Z|00105|coverage(ovn_statctrl3)|INFO|lflow_cache_delete         0.0/sec     0.033/sec        1.7553/sec   total: 6319
2026-06-22T13:04:51.862Z|00106|coverage(ovn_statctrl3)|INFO|lflow_cache_miss           0.0/sec     0.583/sec        4.0978/sec   total: 14752
2026-06-22T13:04:51.862Z|00107|coverage(ovn_statctrl3)|INFO|lflow_cache_hit            0.0/sec     0.083/sec       26.9294/sec   total: 96946
2026-06-22T13:04:51.862Z|00108|coverage(ovn_statctrl3)|INFO|lflow_cache_add            0.0/sec     0.017/sec        2.0686/sec   total: 7447
2026-06-22T13:04:51.862Z|00109|coverage(ovn_statctrl3)|INFO|lflow_cache_free_matches   0.0/sec     0.017/sec        1.3831/sec   total: 4979
2026-06-22T13:04:51.862Z|00110|coverage(ovn_statctrl3)|INFO|lflow_cache_free_expr      0.0/sec     0.017/sec        0.3722/sec   total: 1340
2026-06-22T13:04:51.862Z|00111|coverage(ovn_statctrl3)|INFO|lflow_cache_add_matches    0.0/sec     0.000/sec        1.4800/sec   total: 5328
2026-06-22T13:04:51.862Z|00112|coverage(ovn_statctrl3)|INFO|lflow_cache_add_expr       0.0/sec     0.017/sec        0.5886/sec   total: 2119
2026-06-22T13:04:51.862Z|00113|coverage(ovn_statctrl3)|INFO|consider_logical_flow      0.0/sec     0.350/sec        8.6258/sec   total: 31053
2026-06-22T13:04:51.862Z|00114|coverage(ovn_statctrl3)|INFO|lflow_run                  0.0/sec     0.000/sec        0.0058/sec   total: 21
2026-06-22T13:04:51.862Z|00115|coverage(ovn_statctrl3)|INFO|110 events never hit
2026-06-22T13:04:51.862Z|00116|poll_loop(ovn_statctrl3)|INFO|Dropped 2 log messages in last 39 seconds (most recently, 39 seconds ago) due to excessive rate
2026-06-22T13:04:51.862Z|00117|poll_loop(ovn_statctrl3)|INFO|wakeup due to [POLLIN] on fd 36 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (56% CPU usage)
2026-06-22T13:05:02.789Z|00525|timeval|WARN|Unreasonably long 5034ms poll interval (0ms user, 4252ms system)
2026-06-22T13:05:02.789Z|00526|timeval|WARN|faults: 25 minor, 186 major
2026-06-22T13:05:02.789Z|00527|timeval|WARN|disk: 45576 reads, 0 writes
2026-06-22T13:05:02.789Z|00528|timeval|WARN|context switches: 193 voluntary, 4078 involuntary
2026-06-22T13:05:02.789Z|00529|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (94% CPU usage)
2026-06-22T13:05:02.793Z|00530|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (94% CPU usage)
2026-06-22T13:05:02.794Z|00531|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (94% CPU usage)
2026-06-22T13:05:52.542Z|00118|timeval(ovn_statctrl3)|WARN|Unreasonably long 1901ms poll interval (0ms user, 1044ms system)
2026-06-22T13:05:52.543Z|00119|timeval(ovn_statctrl3)|WARN|faults: 9 minor, 47 major
2026-06-22T13:05:52.543Z|00120|timeval(ovn_statctrl3)|WARN|disk: 11568 reads, 0 writes
2026-06-22T13:05:52.543Z|00121|timeval(ovn_statctrl3)|WARN|context switches: 47 voluntary, 1021 involuntary
2026-06-22T13:05:52.543Z|00122|coverage(ovn_statctrl3)|INFO|Dropped 1 log messages in last 50 seconds (most recently, 50 seconds ago) due to excessive rate
2026-06-22T13:05:52.543Z|00123|coverage(ovn_statctrl3)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=ee99595d:
2026-06-22T13:05:52.543Z|00124|coverage(ovn_statctrl3)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:05:52.543Z|00125|coverage(ovn_statctrl3)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:05:52.543Z|00126|coverage(ovn_statctrl3)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T13:05:52.543Z|00127|coverage(ovn_statctrl3)|INFO|vconn_sent                 0.4/sec     0.167/sec        4.9564/sec   total: 17843
2026-06-22T13:05:52.543Z|00128|coverage(ovn_statctrl3)|INFO|vconn_received             0.4/sec     0.167/sec        0.2414/sec   total: 869
2026-06-22T13:05:52.543Z|00129|coverage(ovn_statctrl3)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:05:52.543Z|00130|coverage(ovn_statctrl3)|INFO|util_xalloc              192.6/sec   435.533/sec     1758.4600/sec   total: 6330456
2026-06-22T13:05:52.543Z|00131|coverage(ovn_statctrl3)|INFO|long_poll_interval         0.2/sec     0.050/sec        0.0058/sec   total: 21
2026-06-22T13:05:52.543Z|00132|coverage(ovn_statctrl3)|INFO|stream_open                0.0/sec     0.000/sec        0.0028/sec   total: 10
2026-06-22T13:05:52.543Z|00133|coverage(ovn_statctrl3)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:05:52.543Z|00134|coverage(ovn_statctrl3)|INFO|seq_change                 0.6/sec     2.933/sec        2.5811/sec   total: 9292
2026-06-22T13:05:52.543Z|00135|coverage(ovn_statctrl3)|INFO|rconn_sent                 0.4/sec     0.167/sec        4.9553/sec   total: 17839
2026-06-22T13:05:52.543Z|00136|coverage(ovn_statctrl3)|INFO|rconn_queued               0.4/sec     0.167/sec        4.9553/sec   total: 17839
2026-06-22T13:05:52.543Z|00137|coverage(ovn_statctrl3)|INFO|poll_zero_timeout          0.4/sec     0.300/sec        0.0825/sec   total: 297
2026-06-22T13:05:52.543Z|00138|coverage(ovn_statctrl3)|INFO|poll_create_node           2.6/sec     9.517/sec        7.7431/sec   total: 27875
2026-06-22T13:05:52.543Z|00139|coverage(ovn_statctrl3)|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T13:05:52.543Z|00140|coverage(ovn_statctrl3)|INFO|txn_success                0.0/sec     0.000/sec        0.0447/sec   total: 161
2026-06-22T13:05:52.543Z|00141|coverage(ovn_statctrl3)|INFO|txn_incomplete             0.0/sec     0.000/sec        0.0714/sec   total: 257
2026-06-22T13:05:52.543Z|00142|coverage(ovn_statctrl3)|INFO|txn_unchanged              0.8/sec     1.233/sec        0.7589/sec   total: 2732
2026-06-22T13:05:52.543Z|00143|coverage(ovn_statctrl3)|INFO|hmap_reserve               1.2/sec     2.467/sec        1.1003/sec   total: 3961
2026-06-22T13:05:52.543Z|00144|coverage(ovn_statctrl3)|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T13:05:52.543Z|00145|coverage(ovn_statctrl3)|INFO|hmap_expand                4.8/sec    10.783/sec       29.6456/sec   total: 106724
2026-06-22T13:05:52.543Z|00146|coverage(ovn_statctrl3)|INFO|hmap_pathological          0.0/sec     0.000/sec        0.2683/sec   total: 966
2026-06-22T13:05:52.543Z|00147|coverage(ovn_statctrl3)|INFO|miniflow_malloc            0.0/sec     0.000/sec       56.0292/sec   total: 201705
2026-06-22T13:05:52.543Z|00148|coverage(ovn_statctrl3)|INFO|flow_extract               0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:05:52.543Z|00149|coverage(ovn_statctrl3)|INFO|physical_run               0.0/sec     0.000/sec        0.0331/sec   total: 119
2026-06-22T13:05:52.543Z|00150|coverage(ovn_statctrl3)|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0039/sec   total: 14
2026-06-22T13:05:52.543Z|00151|coverage(ovn_statctrl3)|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T13:05:52.543Z|00152|coverage(ovn_statctrl3)|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0044/sec   total: 16
2026-06-22T13:05:52.543Z|00153|coverage(ovn_statctrl3)|INFO|lflow_conj_alloc           0.0/sec     0.000/sec        0.0211/sec   total: 76
2026-06-22T13:05:52.543Z|00154|coverage(ovn_statctrl3)|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0014/sec   total: 5
2026-06-22T13:05:52.543Z|00155|coverage(ovn_statctrl3)|INFO|lflow_cache_delete         0.0/sec     0.000/sec        1.7553/sec   total: 6319
2026-06-22T13:05:52.543Z|00156|coverage(ovn_statctrl3)|INFO|lflow_cache_miss           0.0/sec     0.000/sec        4.0978/sec   total: 14752
2026-06-22T13:05:52.543Z|00157|coverage(ovn_statctrl3)|INFO|lflow_cache_hit            0.0/sec     0.000/sec       26.9294/sec   total: 96946
2026-06-22T13:05:52.543Z|00158|coverage(ovn_statctrl3)|INFO|lflow_cache_add            0.0/sec     0.000/sec        2.0686/sec   total: 7447
2026-06-22T13:05:52.543Z|00159|coverage(ovn_statctrl3)|INFO|lflow_cache_free_matches   0.0/sec     0.000/sec        1.3831/sec   total: 4979
2026-06-22T13:05:52.543Z|00160|coverage(ovn_statctrl3)|INFO|lflow_cache_free_expr      0.0/sec     0.000/sec        0.3722/sec   total: 1340
2026-06-22T13:05:52.543Z|00161|coverage(ovn_statctrl3)|INFO|lflow_cache_add_matches    0.0/sec     0.000/sec        1.4800/sec   total: 5328
2026-06-22T13:05:52.543Z|00162|coverage(ovn_statctrl3)|INFO|lflow_cache_add_expr       0.0/sec     0.000/sec        0.5886/sec   total: 2119
2026-06-22T13:05:52.543Z|00163|coverage(ovn_statctrl3)|INFO|consider_logical_flow      0.0/sec     0.000/sec        8.6258/sec   total: 31053
2026-06-22T13:05:52.543Z|00164|coverage(ovn_statctrl3)|INFO|lflow_run                  0.0/sec     0.000/sec        0.0058/sec   total: 21
2026-06-22T13:05:52.543Z|00165|coverage(ovn_statctrl3)|INFO|110 events never hit
2026-06-22T13:05:52.545Z|00532|timeval|WARN|Unreasonably long 11796ms poll interval (0ms user, 8297ms system)
2026-06-22T13:05:52.545Z|00533|timeval|WARN|faults: 26 minor, 325 major
2026-06-22T13:05:52.545Z|00534|timeval|WARN|disk: 81296 reads, 0 writes
2026-06-22T13:05:52.545Z|00535|timeval|WARN|context switches: 327 voluntary, 7727 involuntary
2026-06-22T13:05:52.545Z|00536|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (74% CPU usage)
2026-06-22T13:05:52.545Z|00537|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (74% CPU usage)
2026-06-22T13:05:52.546Z|00538|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (74% CPU usage)
2026-06-22T13:06:21.558Z|00066|timeval(ovn_pinctrl0)|WARN|Unreasonably long 4417ms poll interval (0ms user, 1255ms system)
2026-06-22T13:06:21.559Z|00067|timeval(ovn_pinctrl0)|WARN|faults: 10 minor, 49 major
2026-06-22T13:06:21.559Z|00068|timeval(ovn_pinctrl0)|WARN|disk: 12808 reads, 0 writes
2026-06-22T13:06:21.559Z|00069|timeval(ovn_pinctrl0)|WARN|context switches: 51 voluntary, 1435 involuntary
2026-06-22T13:06:21.560Z|00539|timeval|WARN|Unreasonably long 18716ms poll interval (1ms user, 15436ms system)
2026-06-22T13:06:21.560Z|00540|timeval|WARN|faults: 64 minor, 944 major
2026-06-22T13:06:21.560Z|00541|timeval|WARN|disk: 247576 reads, 0 writes
2026-06-22T13:06:21.560Z|00542|timeval|WARN|context switches: 963 voluntary, 14215 involuntary
2026-06-22T13:06:21.560Z|00543|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (82% CPU usage)
2026-06-22T13:06:21.562Z|00544|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.109:33056<->10.4.3.109:6642) at lib/stream-ssl.c:842 (82% CPU usage)
2026-06-22T13:06:21.562Z|00545|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (82% CPU usage)