2026-06-22T14:18:58.861Z|00001|vlog|INFO|opened log file /var/log/ovn/ovn-controller.log
2026-06-22T14:18:58.863Z|00002|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T14:18:58.864Z|00003|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T14:18:58.865Z|00004|main|INFO|OVN internal version is : [24.03.6-20.33.0-76.8]
2026-06-22T14:18:58.865Z|00005|main|INFO|OVS IDL reconnected, force recompute.
2026-06-22T14:18:58.865Z|00006|main|INFO|OVNSB IDL reconnected, force recompute.
2026-06-22T14:23:27.752Z|00007|memory|INFO|8076 kB peak resident set size after 268.9 seconds
2026-06-22T14:23:27.752Z|00008|memory|INFO|idl-cells-Open_vSwitch:101
2026-06-22T14:23:27.752Z|00009|jsonrpc|WARN|unix:/var/run/openvswitch/db.sock: send error: Broken pipe
2026-06-22T14:23:27.753Z|00010|reconnect|WARN|unix:/var/run/openvswitch/db.sock: connection dropped (Broken pipe)
2026-06-22T14:23:28.753Z|00011|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T14:23:28.753Z|00012|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T14:23:28.820Z|00013|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:23:28.820Z|00014|reconnect|INFO|ssl:10.4.3.247:6642: connection attempt failed (Connection refused)
2026-06-22T14:23:29.821Z|00015|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:23:29.821Z|00016|reconnect|INFO|ssl:10.4.3.247:6642: connection attempt failed (Connection refused)
2026-06-22T14:23:29.821Z|00017|reconnect|INFO|ssl:10.4.3.247:6642: waiting 2 seconds before reconnect
2026-06-22T14:23:31.814Z|00001|vlog|INFO|opened log file /var/log/ovn/ovn-controller.log
2026-06-22T14:23:31.815Z|00002|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T14:23:31.815Z|00003|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T14:23:31.817Z|00004|main|INFO|OVN internal version is : [24.03.6-20.33.0-76.8]
2026-06-22T14:23:31.817Z|00005|main|INFO|OVS IDL reconnected, force recompute.
2026-06-22T14:23:31.821Z|00006|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:23:31.821Z|00007|main|INFO|OVNSB IDL reconnected, force recompute.
2026-06-22T14:23:31.828Z|00008|reconnect|INFO|ssl:10.4.3.247:6642: connected
2026-06-22T14:23:31.833Z|00009|features|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T14:23:31.833Z|00010|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T14:23:31.833Z|00011|features|INFO|OVS Feature: ct_zero_snat, state: supported
2026-06-22T14:23:31.833Z|00012|features|INFO|OVS Feature: ct_flush, state: supported
2026-06-22T14:23:31.833Z|00013|features|INFO|OVS Feature: dp_hash_l4_sym_support, state: supported
2026-06-22T14:23:31.833Z|00014|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connecting...
2026-06-22T14:23:31.833Z|00015|main|INFO|OVS feature set changed, force recompute.
2026-06-22T14:23:31.833Z|00016|ofctrl|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T14:23:31.833Z|00017|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T14:23:31.833Z|00018|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T14:23:31.833Z|00019|main|INFO|OVS OpenFlow connection reconnected,force recompute.
2026-06-22T14:23:31.833Z|00020|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T14:23:31.833Z|00021|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected
2026-06-22T14:23:31.833Z|00022|main|INFO|OVS feature set changed, force recompute.
2026-06-22T14:23:31.834Z|00023|features|INFO|OVS DB schema supports 4 flow table prefixes, our IDL supports: 4
2026-06-22T14:23:31.834Z|00024|main|INFO|Setting flow table prefixes: ip_src, ip_dst, ipv6_src, ipv6_dst.
2026-06-22T14:23:31.835Z|00001|pinctrl(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T14:23:31.835Z|00002|rconn(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T14:23:31.835Z|00001|statctrl(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch
2026-06-22T14:23:31.835Z|00002|rconn(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting...
2026-06-22T14:23:31.835Z|00003|rconn(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T14:23:31.835Z|00003|rconn(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected
2026-06-22T14:23:46.004Z|00025|memory|INFO|10000 kB peak resident set size after 14.2 seconds
2026-06-22T14:23:46.004Z|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-22T14:23:56.832Z|00027|binding|INFO|Claiming lport cr-lrp-901336b5-5d4b-4ef7-ab65-27480eff7b58 for this chassis.
2026-06-22T14:23:56.832Z|00028|binding|INFO|cr-lrp-901336b5-5d4b-4ef7-ab65-27480eff7b58: Claiming fa:16:3e:20:47:7f 172.24.5.74/24
2026-06-22T14:23:56.837Z|00029|binding|INFO|Setting lport cr-lrp-901336b5-5d4b-4ef7-ab65-27480eff7b58 up in Southbound
2026-06-22T14:24:31.013Z|00030|memory_trim|INFO|Detected inactivity (last active 30003 ms ago): trimming memory
2026-06-22T14:25:30.077Z|00031|memory_trim|INFO|Detected inactivity (last active 30005 ms ago): trimming memory
2026-06-22T14:26:19.459Z|00032|binding|INFO|Claiming lport cr-lrp-165485ac-9f9f-4951-9849-78150b1e745a for this chassis.
2026-06-22T14:26:19.459Z|00033|binding|INFO|cr-lrp-165485ac-9f9f-4951-9849-78150b1e745a: Claiming fa:16:3e:f5:57:1f 172.24.5.247/24 2001:db8::166/64
2026-06-22T14:26:19.465Z|00034|binding|INFO|Setting lport cr-lrp-165485ac-9f9f-4951-9849-78150b1e745a up in Southbound
2026-06-22T14:26:19.761Z|00035|binding|INFO|Claiming lport cr-lrp-391a510e-0152-4301-8039-719bc3bb1ec9 for this chassis.
2026-06-22T14:26:19.761Z|00036|binding|INFO|cr-lrp-391a510e-0152-4301-8039-719bc3bb1ec9: Claiming fa:16:3e:2c:bb:e6 172.24.5.19/24 2001:db8::da/64
2026-06-22T14:26:19.773Z|00037|binding|INFO|Setting lport cr-lrp-391a510e-0152-4301-8039-719bc3bb1ec9 up in Southbound
2026-06-22T14:26:19.969Z|00038|binding|INFO|Claiming lport cr-lrp-95d5b8ec-ba35-45c3-8133-66bf4de4e9e5 for this chassis.
2026-06-22T14:26:19.969Z|00039|binding|INFO|cr-lrp-95d5b8ec-ba35-45c3-8133-66bf4de4e9e5: Claiming fa:16:3e:e4:68:24 172.24.5.83/24 2001:db8::277/64
2026-06-22T14:26:19.975Z|00040|binding|INFO|Setting lport cr-lrp-95d5b8ec-ba35-45c3-8133-66bf4de4e9e5 up in Southbound
2026-06-22T14:26:21.300Z|00041|binding|INFO|Claiming lport cr-lrp-445ae6f8-2bb0-4fab-b73b-8c6e906b4d07 for this chassis.
2026-06-22T14:26:21.300Z|00042|binding|INFO|cr-lrp-445ae6f8-2bb0-4fab-b73b-8c6e906b4d07: Claiming fa:16:3e:f9:b3:54 172.24.5.139/24 2001:db8::3c4/64
2026-06-22T14:26:21.308Z|00043|binding|INFO|Setting lport cr-lrp-445ae6f8-2bb0-4fab-b73b-8c6e906b4d07 up in Southbound
2026-06-22T14:26:21.850Z|00044|binding|INFO|Claiming lport cr-lrp-8163888b-20cd-4a86-a289-346ccdcb08c5 for this chassis.
2026-06-22T14:26:21.850Z|00045|binding|INFO|cr-lrp-8163888b-20cd-4a86-a289-346ccdcb08c5: Claiming fa:16:3e:4a:67:7b 172.24.5.194/24 2001:db8::22b/64
2026-06-22T14:26:21.862Z|00046|binding|INFO|Setting lport cr-lrp-8163888b-20cd-4a86-a289-346ccdcb08c5 up in Southbound
2026-06-22T14:26:22.194Z|00047|binding|INFO|Claiming lport cr-lrp-d2219330-bf0d-42c1-bff3-12f42723bfb3 for this chassis.
2026-06-22T14:26:22.194Z|00048|binding|INFO|cr-lrp-d2219330-bf0d-42c1-bff3-12f42723bfb3: Claiming fa:16:3e:8c:00:5e 172.24.5.136/24 2001:db8::131/64
2026-06-22T14:26:22.209Z|00049|binding|INFO|Setting lport cr-lrp-d2219330-bf0d-42c1-bff3-12f42723bfb3 up in Southbound
2026-06-22T14:26:22.752Z|00050|binding|INFO|Claiming lport cr-lrp-5e237c59-6e03-4415-b959-74da5de2e90e for this chassis.
2026-06-22T14:26:22.752Z|00051|binding|INFO|cr-lrp-5e237c59-6e03-4415-b959-74da5de2e90e: Claiming fa:16:3e:d1:e3:90 172.24.5.37/24 2001:db8::e1/64
2026-06-22T14:26:22.761Z|00052|binding|INFO|Setting lport cr-lrp-5e237c59-6e03-4415-b959-74da5de2e90e up in Southbound
2026-06-22T14:26:24.062Z|00053|binding|INFO|Claiming lport cr-lrp-a8e89c74-804e-4857-ac2b-2e26e2fea4fe for this chassis.
2026-06-22T14:26:24.062Z|00054|binding|INFO|cr-lrp-a8e89c74-804e-4857-ac2b-2e26e2fea4fe: Claiming fa:16:3e:53:0b:3d 172.24.5.67/24 2001:db8::9d/64
2026-06-22T14:26:24.067Z|00055|binding|INFO|Setting lport cr-lrp-a8e89c74-804e-4857-ac2b-2e26e2fea4fe up in Southbound
2026-06-22T14:26:32.647Z|00056|binding|INFO|Claiming lport cr-lrp-f89862c6-87a8-453c-baf7-332812d504d6 for this chassis.
2026-06-22T14:26:32.648Z|00057|binding|INFO|cr-lrp-f89862c6-87a8-453c-baf7-332812d504d6: Claiming fa:16:3e:4a:4b:1b 172.24.5.177/24 2001:db8::23d/64
2026-06-22T14:26:32.661Z|00058|binding|INFO|Setting lport cr-lrp-f89862c6-87a8-453c-baf7-332812d504d6 up in Southbound
2026-06-22T14:26:33.168Z|00059|memory|INFO|peak resident set size grew 92% in last 167.2 seconds, from 10000 kB to 19216 kB
2026-06-22T14:26:33.168Z|00060|memory|INFO|idl-cells-OVN_Southbound:13104 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:692 lflow-cache-entries-cache-matches:291 lflow-cache-size-KB:3119 local_datapath_usage-KB:4 ofctrl_desired_flow_usage-KB:837 ofctrl_installed_flow_usage-KB:625 ofctrl_sb_flow_ref_usage-KB:306
2026-06-22T14:26:33.697Z|00061|binding|INFO|Claiming lport cr-lrp-8027fb85-a4fa-4be6-8b4b-1e5a14d1c1da for this chassis.
2026-06-22T14:26:33.697Z|00062|binding|INFO|cr-lrp-8027fb85-a4fa-4be6-8b4b-1e5a14d1c1da: Claiming fa:16:3e:fd:5b:6a 172.24.5.241/24 2001:db8::2d1/64
2026-06-22T14:26:33.708Z|00063|binding|INFO|Setting lport cr-lrp-8027fb85-a4fa-4be6-8b4b-1e5a14d1c1da up in Southbound
2026-06-22T14:26:34.252Z|00064|binding|INFO|Claiming lport cr-lrp-90096474-0c93-4be6-b8df-7417a4991ce1 for this chassis.
2026-06-22T14:26:34.252Z|00065|binding|INFO|cr-lrp-90096474-0c93-4be6-b8df-7417a4991ce1: Claiming fa:16:3e:3e:ba:84 172.24.5.35/24 2001:db8::f1/64
2026-06-22T14:26:34.265Z|00066|binding|INFO|Setting lport cr-lrp-90096474-0c93-4be6-b8df-7417a4991ce1 up in Southbound
2026-06-22T14:26:36.285Z|00067|binding|INFO|Claiming lport cr-lrp-6538d2ed-87a5-40b1-ac17-d7e82c371c61 for this chassis.
2026-06-22T14:26:36.285Z|00068|binding|INFO|cr-lrp-6538d2ed-87a5-40b1-ac17-d7e82c371c61: Claiming fa:16:3e:75:84:9a 172.24.5.23/24 2001:db8::2f6/64
2026-06-22T14:26:36.301Z|00069|binding|INFO|Setting lport cr-lrp-6538d2ed-87a5-40b1-ac17-d7e82c371c61 up in Southbound
2026-06-22T14:26:38.745Z|00070|binding|INFO|Claiming lport cr-lrp-537dcdd5-db81-4041-96af-2e2f97b989d5 for this chassis.
2026-06-22T14:26:38.745Z|00071|binding|INFO|cr-lrp-537dcdd5-db81-4041-96af-2e2f97b989d5: Claiming fa:16:3e:9a:62:4e 172.24.5.174/24 2001:db8::87/64
2026-06-22T14:26:38.759Z|00072|binding|INFO|Setting lport cr-lrp-537dcdd5-db81-4041-96af-2e2f97b989d5 up in Southbound
2026-06-22T14:26:44.021Z|00073|binding|INFO|Claiming lport cr-lrp-30a68a97-3893-493b-a0a7-e5bbf568befc for this chassis.
2026-06-22T14:26:44.021Z|00074|binding|INFO|cr-lrp-30a68a97-3893-493b-a0a7-e5bbf568befc: Claiming fa:16:3e:9f:a7:77 172.24.5.162/24 2001:db8::3ed/64
2026-06-22T14:26:44.032Z|00075|binding|INFO|Setting lport cr-lrp-30a68a97-3893-493b-a0a7-e5bbf568befc up in Southbound
2026-06-22T14:26:45.521Z|00076|binding|INFO|Claiming lport cr-lrp-264d158c-2212-41cd-828b-6b179a8af193 for this chassis.
2026-06-22T14:26:45.521Z|00077|binding|INFO|cr-lrp-264d158c-2212-41cd-828b-6b179a8af193: Claiming fa:16:3e:5c:b4:f8 172.24.5.45/24 2001:db8::2a7/64
2026-06-22T14:26:45.536Z|00078|binding|INFO|Setting lport cr-lrp-264d158c-2212-41cd-828b-6b179a8af193 up in Southbound
2026-06-22T14:26:47.741Z|00079|binding|INFO|Claiming lport cr-lrp-95748721-cb7c-4369-a60a-c2ec1f2b55d9 for this chassis.
2026-06-22T14:26:47.741Z|00080|binding|INFO|cr-lrp-95748721-cb7c-4369-a60a-c2ec1f2b55d9: Claiming fa:16:3e:06:92:50 172.24.5.181/24 2001:db8::76/64
2026-06-22T14:26:47.755Z|00081|binding|INFO|Setting lport cr-lrp-95748721-cb7c-4369-a60a-c2ec1f2b55d9 up in Southbound
2026-06-22T14:26:55.676Z|00082|binding|INFO|Claiming lport 4d66434e-7c2d-452c-be14-5ea29d16b755 for this chassis.
2026-06-22T14:26:55.676Z|00083|binding|INFO|4d66434e-7c2d-452c-be14-5ea29d16b755: Claiming fa:16:3e:c9:56:3e 10.1.0.14
2026-06-22T14:26:55.705Z|00084|binding|INFO|Setting lport 4d66434e-7c2d-452c-be14-5ea29d16b755 ovn-installed in OVS
2026-06-22T14:26:55.705Z|00085|binding|INFO|Setting lport 4d66434e-7c2d-452c-be14-5ea29d16b755 up in Southbound
2026-06-22T14:26:56.460Z|00086|binding|INFO|Claiming lport 3f984367-01ca-4ee8-81af-034f1b621992 for this chassis.
2026-06-22T14:26:56.460Z|00087|binding|INFO|3f984367-01ca-4ee8-81af-034f1b621992: Claiming fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:26:56.477Z|00088|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 ovn-installed in OVS
2026-06-22T14:26:56.477Z|00089|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 up in Southbound
2026-06-22T14:26:57.214Z|00090|binding|INFO|Claiming lport 68ebf923-8a90-46b4-83bf-bab500b23125 for this chassis.
2026-06-22T14:26:57.214Z|00091|binding|INFO|68ebf923-8a90-46b4-83bf-bab500b23125: Claiming fa:16:3e:88:56:af 10.1.0.6
2026-06-22T14:26:57.242Z|00092|binding|INFO|Setting lport 68ebf923-8a90-46b4-83bf-bab500b23125 ovn-installed in OVS
2026-06-22T14:26:57.242Z|00093|binding|INFO|Setting lport 68ebf923-8a90-46b4-83bf-bab500b23125 up in Southbound
2026-06-22T14:26:57.627Z|00094|binding|INFO|Claiming lport ce9da2bb-ad62-45a2-b594-42bc787fbada for this chassis.
2026-06-22T14:26:57.627Z|00095|binding|INFO|ce9da2bb-ad62-45a2-b594-42bc787fbada: Claiming fa:16:3e:fd:9a:08 10.1.0.9
2026-06-22T14:26:57.649Z|00096|binding|INFO|Setting lport ce9da2bb-ad62-45a2-b594-42bc787fbada ovn-installed in OVS
2026-06-22T14:26:57.649Z|00097|binding|INFO|Setting lport ce9da2bb-ad62-45a2-b594-42bc787fbada up in Southbound
2026-06-22T14:26:59.464Z|00098|binding|INFO|Releasing lport 48a3c3ed-0f0c-4885-897d-594bf890822f from this chassis (sb_readonly=0)
2026-06-22T14:27:00.595Z|00099|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:27:01.315Z|00100|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:27:04.463Z|00101|binding|INFO|Claiming lport 46687852-4a8c-40e8-a321-46861339e603 for this chassis.
2026-06-22T14:27:04.463Z|00102|binding|INFO|46687852-4a8c-40e8-a321-46861339e603: Claiming fa:16:3e:c0:e6:c7 10.1.0.10
2026-06-22T14:27:04.486Z|00103|binding|INFO|Setting lport 46687852-4a8c-40e8-a321-46861339e603 ovn-installed in OVS
2026-06-22T14:27:05.092Z|00104|binding|INFO|Setting lport 46687852-4a8c-40e8-a321-46861339e603 up in Southbound
2026-06-22T14:27:05.589Z|00105|binding|INFO|Releasing lport 1728cbac-44f5-4705-bcb4-bb0ac27deaa6 from this chassis (sb_readonly=0)
2026-06-22T14:27:10.092Z|00106|binding|INFO|Claiming lport f444f5b3-705c-4592-9c51-5c18bba97079 for this chassis.
2026-06-22T14:27:10.092Z|00107|binding|INFO|f444f5b3-705c-4592-9c51-5c18bba97079: Claiming fa:16:3e:a3:a4:cb 10.1.0.7
2026-06-22T14:27:10.110Z|00108|binding|INFO|Setting lport f444f5b3-705c-4592-9c51-5c18bba97079 ovn-installed in OVS
2026-06-22T14:27:12.885Z|00109|binding|INFO|Setting lport f444f5b3-705c-4592-9c51-5c18bba97079 up in Southbound
2026-06-22T14:27:13.430Z|00110|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:27:26.492Z|00111|reconnect|ERR|ssl:10.4.3.247:6642: no response to inactivity probe after 5.01 seconds, disconnecting
2026-06-22T14:27:26.492Z|00112|reconnect|INFO|ssl:10.4.3.247:6642: connection dropped
2026-06-22T14:27:26.493Z|00113|main|INFO|OVNSB commit failed, force recompute next time.
2026-06-22T14:27:27.499Z|00114|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:27:27.505Z|00115|reconnect|INFO|ssl:10.4.3.247:6642: connected
2026-06-22T14:27:27.597Z|00116|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:27:27.598Z|00117|binding|INFO|Releasing lport 48a3c3ed-0f0c-4885-897d-594bf890822f from this chassis (sb_readonly=0)
2026-06-22T14:27:27.598Z|00118|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:27:27.598Z|00119|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:27:27.599Z|00120|binding|INFO|Releasing lport 1728cbac-44f5-4705-bcb4-bb0ac27deaa6 from this chassis (sb_readonly=0)
2026-06-22T14:27:37.493Z|00121|timeval|WARN|Unreasonably long 5634ms poll interval (3ms user, 4562ms system)
2026-06-22T14:27:37.493Z|00122|timeval|WARN|faults: 603 minor, 4484 major
2026-06-22T14:27:37.493Z|00123|timeval|WARN|disk: 1151888 reads, 0 writes
2026-06-22T14:27:37.493Z|00124|timeval|WARN|context switches: 4535 voluntary, 931 involuntary
2026-06-22T14:27:37.494Z|00125|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=9be5926f:
2026-06-22T14:27:37.494Z|00126|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:27:37.494Z|00127|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:27:37.494Z|00128|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:27:37.494Z|00129|coverage|INFO|vconn_sent                 2.6/sec   101.050/sec        2.5172/sec   total: 9063
2026-06-22T14:27:37.494Z|00130|coverage|INFO|vconn_received             0.6/sec     5.017/sec        0.1228/sec   total: 443
2026-06-22T14:27:37.494Z|00131|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:27:37.494Z|00132|coverage|INFO|util_xalloc              59898.4/sec 39671.250/sec      850.3239/sec   total: 3062124
2026-06-22T14:27:37.494Z|00133|coverage|INFO|stream_open                0.2/sec     0.017/sec        0.0022/sec   total: 8
2026-06-22T14:27:37.494Z|00134|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:27:37.494Z|00135|coverage|INFO|seq_change                15.8/sec    41.717/sec        1.2233/sec   total: 4409
2026-06-22T14:27:37.494Z|00136|coverage|INFO|rconn_sent                 2.6/sec   101.050/sec        2.5161/sec   total: 9059
2026-06-22T14:27:37.494Z|00137|coverage|INFO|rconn_queued               2.6/sec   101.050/sec        2.5161/sec   total: 9059
2026-06-22T14:27:37.494Z|00138|coverage|INFO|poll_zero_timeout          1.6/sec     0.633/sec        0.0317/sec   total: 114
2026-06-22T14:27:37.494Z|00139|coverage|INFO|poll_create_node          53.0/sec   126.400/sec        3.6853/sec   total: 13283
2026-06-22T14:27:37.494Z|00140|coverage|INFO|txn_try_again              0.2/sec     0.017/sec        0.0003/sec   total: 1
2026-06-22T14:27:37.494Z|00141|coverage|INFO|txn_success                0.0/sec     0.933/sec        0.0247/sec   total: 89
2026-06-22T14:27:37.494Z|00142|coverage|INFO|txn_incomplete             0.0/sec     1.633/sec        0.0458/sec   total: 165
2026-06-22T14:27:37.494Z|00143|coverage|INFO|txn_unchanged              5.0/sec    11.950/sec        0.3531/sec   total: 1273
2026-06-22T14:27:37.494Z|00144|coverage|INFO|hmap_reserve              28.0/sec    14.850/sec        0.2475/sec   total: 898
2026-06-22T14:27:37.494Z|00145|coverage|INFO|hmap_expand              1162.0/sec   620.817/sec       13.7044/sec   total: 49354
2026-06-22T14:27:37.494Z|00146|coverage|INFO|hmap_pathological         10.2/sec    18.667/sec        0.3917/sec   total: 1412
2026-06-22T14:27:37.494Z|00147|coverage|INFO|miniflow_malloc          1171.4/sec  1301.850/sec       26.1028/sec   total: 93970
2026-06-22T14:27:37.494Z|00148|coverage|INFO|physical_run               0.2/sec     0.767/sec        0.0211/sec   total: 76
2026-06-22T14:27:37.494Z|00149|coverage|INFO|lflow_conj_free            0.0/sec     0.267/sec        0.0044/sec   total: 16
2026-06-22T14:27:37.494Z|00150|coverage|INFO|lflow_conj_alloc           1.6/sec     0.650/sec        0.0108/sec   total: 39
2026-06-22T14:27:37.494Z|00151|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:27:37.494Z|00152|coverage|INFO|lflow_cache_delete         0.0/sec    34.533/sec        0.9000/sec   total: 3240
2026-06-22T14:27:37.494Z|00153|coverage|INFO|lflow_cache_miss          37.4/sec    89.883/sec        2.1186/sec   total: 7627
2026-06-22T14:27:37.494Z|00154|coverage|INFO|lflow_cache_hit          702.6/sec   592.983/sec       11.4269/sec   total: 41137
2026-06-22T14:27:37.494Z|00155|coverage|INFO|lflow_cache_add            0.0/sec    46.217/sec        1.3147/sec   total: 4733
2026-06-22T14:27:37.494Z|00156|coverage|INFO|lflow_cache_free_matches   0.0/sec    29.133/sec        0.7972/sec   total: 2870
2026-06-22T14:27:37.494Z|00157|coverage|INFO|lflow_cache_free_expr      0.0/sec     5.400/sec        0.1028/sec   total: 370
2026-06-22T14:27:37.494Z|00158|coverage|INFO|lflow_cache_add_matches    0.0/sec    31.783/sec        0.9128/sec   total: 3286
2026-06-22T14:27:37.494Z|00159|coverage|INFO|lflow_cache_add_expr       0.0/sec    14.433/sec        0.4019/sec   total: 1447
2026-06-22T14:27:37.494Z|00160|coverage|INFO|consider_logical_flow    318.0/sec   163.117/sec        3.4189/sec   total: 12308
2026-06-22T14:27:37.494Z|00161|coverage|INFO|lflow_run                  0.2/sec     0.067/sec        0.0019/sec   total: 7
2026-06-22T14:27:37.494Z|00162|coverage|INFO|115 events never hit
2026-06-22T14:27:37.494Z|00163|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (64% CPU usage)
2026-06-22T14:27:37.681Z|00164|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (64% CPU usage)
2026-06-22T14:27:40.072Z|00165|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (64% CPU usage)
2026-06-22T14:27:40.090Z|00166|binding|INFO|Claiming lport 997c38ee-484b-4060-96db-dc3e4c0ccd68 for this chassis.
2026-06-22T14:27:40.090Z|00167|binding|INFO|997c38ee-484b-4060-96db-dc3e4c0ccd68: Claiming fa:16:3e:02:52:83 10.1.0.8
2026-06-22T14:27:40.135Z|00168|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (64% CPU usage)
2026-06-22T14:27:40.152Z|00169|binding|INFO|Setting lport 997c38ee-484b-4060-96db-dc3e4c0ccd68 ovn-installed in OVS
2026-06-22T14:27:40.163Z|00170|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (64% CPU usage)
2026-06-22T14:27:44.251Z|00171|timeval|WARN|Unreasonably long 1519ms poll interval (3ms user, 1258ms system)
2026-06-22T14:27:44.251Z|00172|timeval|WARN|faults: 168 minor, 1016 major
2026-06-22T14:27:44.251Z|00173|timeval|WARN|disk: 253920 reads, 0 writes
2026-06-22T14:27:44.251Z|00174|timeval|WARN|context switches: 1024 voluntary, 618 involuntary
2026-06-22T14:27:44.252Z|00175|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=f58f7fc9:
2026-06-22T14:27:44.252Z|00176|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:27:44.252Z|00177|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:27:44.252Z|00178|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:27:44.252Z|00179|coverage|INFO|vconn_sent                 0.2/sec    86.967/sec        2.5175/sec   total: 9119
2026-06-22T14:27:44.252Z|00180|coverage|INFO|vconn_received             0.8/sec     4.467/sec        0.1239/sec   total: 452
2026-06-22T14:27:44.252Z|00181|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:27:44.252Z|00182|coverage|INFO|util_xalloc              196.0/sec 36024.850/sec      850.5961/sec   total: 3076325
2026-06-22T14:27:44.252Z|00183|coverage|INFO|long_poll_interval         0.0/sec     0.000/sec        0.0000/sec   total: 1
2026-06-22T14:27:44.252Z|00184|coverage|INFO|stream_open                0.0/sec     0.017/sec        0.0022/sec   total: 8
2026-06-22T14:27:44.252Z|00185|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:27:44.252Z|00186|coverage|INFO|seq_change                 1.4/sec    35.617/sec        1.2253/sec   total: 4467
2026-06-22T14:27:44.252Z|00187|coverage|INFO|rconn_sent                 0.2/sec    86.967/sec        2.5164/sec   total: 9115
2026-06-22T14:27:44.252Z|00188|coverage|INFO|rconn_queued               0.2/sec    86.967/sec        2.5164/sec   total: 9115
2026-06-22T14:27:44.252Z|00189|coverage|INFO|poll_zero_timeout          0.0/sec     0.567/sec        0.0317/sec   total: 116
2026-06-22T14:27:44.252Z|00190|coverage|INFO|poll_create_node           4.8/sec   108.867/sec        3.6919/sec   total: 13445
2026-06-22T14:27:44.252Z|00191|coverage|INFO|txn_try_again              0.0/sec     0.017/sec        0.0003/sec   total: 1
2026-06-22T14:27:44.252Z|00192|coverage|INFO|txn_success                0.0/sec     0.833/sec        0.0247/sec   total: 90
2026-06-22T14:27:44.252Z|00193|coverage|INFO|txn_incomplete             0.0/sec     1.483/sec        0.0458/sec   total: 170
2026-06-22T14:27:44.252Z|00194|coverage|INFO|txn_unchanged              0.4/sec    10.333/sec        0.3536/sec   total: 1280
2026-06-22T14:27:44.252Z|00195|coverage|INFO|hmap_reserve               1.4/sec    14.967/sec        0.2494/sec   total: 940
2026-06-22T14:27:44.252Z|00196|coverage|INFO|hmap_expand                3.6/sec   570.350/sec       13.7094/sec   total: 49574
2026-06-22T14:27:44.252Z|00197|coverage|INFO|hmap_pathological          0.4/sec    15.850/sec        0.3922/sec   total: 1427
2026-06-22T14:27:44.252Z|00198|coverage|INFO|miniflow_malloc            0.0/sec  1141.333/sec       26.1028/sec   total: 94111
2026-06-22T14:27:44.252Z|00199|coverage|INFO|physical_run               0.0/sec     0.583/sec        0.0211/sec   total: 76
2026-06-22T14:27:44.252Z|00200|coverage|INFO|lflow_conj_free            0.0/sec     0.267/sec        0.0044/sec   total: 16
2026-06-22T14:27:44.252Z|00201|coverage|INFO|lflow_conj_alloc           0.0/sec     0.650/sec        0.0108/sec   total: 40
2026-06-22T14:27:44.252Z|00202|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:27:44.252Z|00203|coverage|INFO|lflow_cache_delete         0.0/sec    28.350/sec        0.9000/sec   total: 3240
2026-06-22T14:27:44.252Z|00204|coverage|INFO|lflow_cache_miss           0.0/sec    76.383/sec        2.1186/sec   total: 7666
2026-06-22T14:27:44.252Z|00205|coverage|INFO|lflow_cache_hit            0.0/sec   532.767/sec       11.4269/sec   total: 41139
2026-06-22T14:27:44.252Z|00206|coverage|INFO|lflow_cache_add            0.0/sec    36.850/sec        1.3147/sec   total: 4736
2026-06-22T14:27:44.252Z|00207|coverage|INFO|lflow_cache_free_matches   0.0/sec    23.367/sec        0.7972/sec   total: 2870
2026-06-22T14:27:44.252Z|00208|coverage|INFO|lflow_cache_free_expr      0.0/sec     4.983/sec        0.1028/sec   total: 370
2026-06-22T14:27:44.252Z|00209|coverage|INFO|lflow_cache_add_matches    0.0/sec    25.450/sec        0.9128/sec   total: 3286
2026-06-22T14:27:44.252Z|00210|coverage|INFO|lflow_cache_add_expr       0.0/sec    11.400/sec        0.4019/sec   total: 1450
2026-06-22T14:27:44.252Z|00211|coverage|INFO|consider_logical_flow      0.0/sec   153.183/sec        3.4189/sec   total: 12325
2026-06-22T14:27:44.252Z|00212|coverage|INFO|lflow_run                  0.0/sec     0.067/sec        0.0019/sec   total: 7
2026-06-22T14:27:44.252Z|00213|coverage|INFO|114 events never hit
2026-06-22T14:27:44.406Z|00214|reconnect|ERR|ssl:10.4.3.247:6642: no response to inactivity probe after 6.56 seconds, disconnecting
2026-06-22T14:27:44.406Z|00215|reconnect|INFO|ssl:10.4.3.247:6642: connection dropped
2026-06-22T14:27:44.407Z|00216|main|INFO|OVNSB commit failed, force recompute next time.
2026-06-22T14:27:45.408Z|00217|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:27:45.418Z|00218|reconnect|INFO|ssl:10.4.3.247:6642: connected
2026-06-22T14:27:45.475Z|00219|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:27:45.476Z|00220|binding|INFO|Releasing lport 48a3c3ed-0f0c-4885-897d-594bf890822f from this chassis (sb_readonly=0)
2026-06-22T14:27:45.476Z|00221|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:27:45.476Z|00222|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:27:45.476Z|00223|binding|INFO|Claiming lport 997c38ee-484b-4060-96db-dc3e4c0ccd68 for this chassis.
2026-06-22T14:27:45.476Z|00224|binding|INFO|997c38ee-484b-4060-96db-dc3e4c0ccd68: Claiming fa:16:3e:02:52:83 10.1.0.8
2026-06-22T14:27:45.476Z|00225|binding|INFO|Releasing lport 1728cbac-44f5-4705-bcb4-bb0ac27deaa6 from this chassis (sb_readonly=0)
2026-06-22T14:27:45.517Z|00226|binding|INFO|Setting lport 997c38ee-484b-4060-96db-dc3e4c0ccd68 up in Southbound
2026-06-22T14:27:45.809Z|00227|binding|INFO|Releasing lport 46f8702f-3aaa-407c-8254-55a912525a84 from this chassis (sb_readonly=0)
2026-06-22T14:27:49.937Z|00228|binding|INFO|Claiming lport 2a62f043-fb1b-435e-a232-99e4f8d0395b for this chassis.
2026-06-22T14:27:49.937Z|00229|binding|INFO|2a62f043-fb1b-435e-a232-99e4f8d0395b: Claiming fa:16:3e:27:0a:d7 10.1.0.5
2026-06-22T14:27:49.961Z|00230|binding|INFO|Setting lport 2a62f043-fb1b-435e-a232-99e4f8d0395b ovn-installed in OVS
2026-06-22T14:27:49.961Z|00231|binding|INFO|Setting lport 2a62f043-fb1b-435e-a232-99e4f8d0395b up in Southbound
2026-06-22T14:27:50.414Z|00232|binding|INFO|Releasing lport 558029d3-5ac0-4a0a-9899-6731a664f339 from this chassis (sb_readonly=0)
2026-06-22T14:27:51.040Z|00233|binding|INFO|Claiming lport cr-lrp-f904c4ef-15ba-4c9a-be53-5c2e3925472e for this chassis.
2026-06-22T14:27:51.040Z|00234|binding|INFO|cr-lrp-f904c4ef-15ba-4c9a-be53-5c2e3925472e: Claiming fa:16:3e:10:31:be 172.24.5.199/24 2001:db8::210/64
2026-06-22T14:27:51.059Z|00235|binding|INFO|Setting lport cr-lrp-f904c4ef-15ba-4c9a-be53-5c2e3925472e up in Southbound
2026-06-22T14:27:56.726Z|00236|binding|INFO|Releasing lport ce9da2bb-ad62-45a2-b594-42bc787fbada from this chassis (sb_readonly=0)
2026-06-22T14:27:56.726Z|00237|binding|INFO|Setting lport ce9da2bb-ad62-45a2-b594-42bc787fbada down in Southbound
2026-06-22T14:27:56.727Z|00238|binding|INFO|Removing iface tapce9da2bb-ad ovn-installed in OVS
2026-06-22T14:27:57.186Z|00239|binding|INFO|Releasing lport 997c38ee-484b-4060-96db-dc3e4c0ccd68 from this chassis (sb_readonly=0)
2026-06-22T14:27:57.186Z|00240|binding|INFO|Setting lport 997c38ee-484b-4060-96db-dc3e4c0ccd68 down in Southbound
2026-06-22T14:27:57.188Z|00241|binding|INFO|Removing iface tap997c38ee-48 ovn-installed in OVS
2026-06-22T14:28:03.804Z|00242|binding|INFO|Releasing lport 4d66434e-7c2d-452c-be14-5ea29d16b755 from this chassis (sb_readonly=0)
2026-06-22T14:28:03.804Z|00243|binding|INFO|Setting lport 4d66434e-7c2d-452c-be14-5ea29d16b755 down in Southbound
2026-06-22T14:28:03.806Z|00244|binding|INFO|Removing iface tap4d66434e-7c ovn-installed in OVS
2026-06-22T14:28:04.088Z|00245|binding|INFO|Claiming lport ce9da2bb-ad62-45a2-b594-42bc787fbada for this chassis.
2026-06-22T14:28:04.088Z|00246|binding|INFO|ce9da2bb-ad62-45a2-b594-42bc787fbada: Claiming fa:16:3e:fd:9a:08 10.1.0.9
2026-06-22T14:28:04.118Z|00247|binding|INFO|Setting lport ce9da2bb-ad62-45a2-b594-42bc787fbada ovn-installed in OVS
2026-06-22T14:28:04.118Z|00248|binding|INFO|Setting lport ce9da2bb-ad62-45a2-b594-42bc787fbada up in Southbound
2026-06-22T14:28:05.722Z|00249|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:28:05.723Z|00250|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:28:05.723Z|00251|binding|INFO|Releasing lport 558029d3-5ac0-4a0a-9899-6731a664f339 from this chassis (sb_readonly=0)
2026-06-22T14:28:05.723Z|00252|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:28:05.723Z|00253|binding|INFO|Releasing lport 1728cbac-44f5-4705-bcb4-bb0ac27deaa6 from this chassis (sb_readonly=0)
2026-06-22T14:28:07.374Z|00004|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:28:07.400Z|00005|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:28:08.048Z|00254|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:28:08.048Z|00255|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:28:08.048Z|00256|binding|INFO|Releasing lport 558029d3-5ac0-4a0a-9899-6731a664f339 from this chassis (sb_readonly=0)
2026-06-22T14:28:08.048Z|00257|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:28:08.048Z|00258|binding|INFO|Releasing lport 1728cbac-44f5-4705-bcb4-bb0ac27deaa6 from this chassis (sb_readonly=0)
2026-06-22T14:28:10.332Z|00259|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:28:10.333Z|00260|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:28:10.333Z|00261|binding|INFO|Releasing lport 558029d3-5ac0-4a0a-9899-6731a664f339 from this chassis (sb_readonly=0)
2026-06-22T14:28:10.333Z|00262|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:28:10.333Z|00263|binding|INFO|Releasing lport 1728cbac-44f5-4705-bcb4-bb0ac27deaa6 from this chassis (sb_readonly=0)
2026-06-22T14:28:10.877Z|00006|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:c0:e6:c7 10.1.0.10
2026-06-22T14:28:10.885Z|00007|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:c0:e6:c7 10.1.0.10
2026-06-22T14:28:12.060Z|00264|binding|INFO|Releasing lport 3f984367-01ca-4ee8-81af-034f1b621992 from this chassis (sb_readonly=0)
2026-06-22T14:28:12.060Z|00265|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 down in Southbound
2026-06-22T14:28:12.062Z|00266|binding|INFO|Removing iface tap3f984367-01 ovn-installed in OVS
2026-06-22T14:28:12.800Z|00008|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:88:56:af 10.1.0.6
2026-06-22T14:28:12.815Z|00009|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:88:56:af 10.1.0.6
2026-06-22T14:28:12.853Z|00267|binding|INFO|Claiming lport 5b15fda1-5dd8-4eb4-90a0-39f9877d5188 for this chassis.
2026-06-22T14:28:12.853Z|00268|binding|INFO|5b15fda1-5dd8-4eb4-90a0-39f9877d5188: Claiming fa:16:3e:b1:00:88 10.1.0.14
2026-06-22T14:28:12.888Z|00269|binding|INFO|Setting lport 5b15fda1-5dd8-4eb4-90a0-39f9877d5188 ovn-installed in OVS
2026-06-22T14:28:12.888Z|00270|binding|INFO|Setting lport 5b15fda1-5dd8-4eb4-90a0-39f9877d5188 up in Southbound
2026-06-22T14:28:13.373Z|00271|binding|INFO|Releasing lport 7ac297b0-bbb8-4c5e-8151-ef715500ed7b from this chassis (sb_readonly=0)
2026-06-22T14:28:14.690Z|00272|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:28:14.692Z|00273|binding|INFO|Releasing lport 7ac297b0-bbb8-4c5e-8151-ef715500ed7b from this chassis (sb_readonly=0)
2026-06-22T14:28:14.692Z|00274|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:28:14.692Z|00275|binding|INFO|Releasing lport 558029d3-5ac0-4a0a-9899-6731a664f339 from this chassis (sb_readonly=0)
2026-06-22T14:28:14.692Z|00276|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:28:14.692Z|00277|binding|INFO|Releasing lport 1728cbac-44f5-4705-bcb4-bb0ac27deaa6 from this chassis (sb_readonly=0)
2026-06-22T14:28:15.844Z|00010|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:a3:a4:cb 10.1.0.7
2026-06-22T14:28:15.921Z|00011|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:a3:a4:cb 10.1.0.7
2026-06-22T14:28:17.796Z|00278|binding|INFO|Claiming lport cr-lrp-2380ff96-1496-48eb-8819-faf013f6d101 for this chassis.
2026-06-22T14:28:17.796Z|00279|binding|INFO|cr-lrp-2380ff96-1496-48eb-8819-faf013f6d101: Claiming fa:16:3e:ec:ec:65 172.24.5.118/24 2001:db8::3ab/64
2026-06-22T14:28:17.810Z|00280|binding|INFO|Setting lport cr-lrp-2380ff96-1496-48eb-8819-faf013f6d101 up in Southbound
2026-06-22T14:28:18.955Z|00012|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:27:0a:d7 10.1.0.5
2026-06-22T14:28:18.975Z|00013|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:27:0a:d7 10.1.0.5
2026-06-22T14:28:19.743Z|00281|binding|INFO|Claiming lport 3f984367-01ca-4ee8-81af-034f1b621992 for this chassis.
2026-06-22T14:28:19.743Z|00282|binding|INFO|3f984367-01ca-4ee8-81af-034f1b621992: Claiming fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:28:19.779Z|00283|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 ovn-installed in OVS
2026-06-22T14:28:19.779Z|00284|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 up in Southbound
2026-06-22T14:28:26.024Z|00014|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:fd:9a:08 10.1.0.9
2026-06-22T14:28:26.038Z|00015|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:fd:9a:08 10.1.0.9
2026-06-22T14:28:33.653Z|00016|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:b1:00:88 10.1.0.14
2026-06-22T14:28:33.663Z|00017|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:b1:00:88 10.1.0.14
2026-06-22T14:28:37.744Z|00018|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:28:37.756Z|00019|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:28:43.589Z|00285|binding|INFO|Releasing lport 46687852-4a8c-40e8-a321-46861339e603 from this chassis (sb_readonly=0)
2026-06-22T14:28:43.589Z|00286|binding|INFO|Setting lport 46687852-4a8c-40e8-a321-46861339e603 down in Southbound
2026-06-22T14:28:43.591Z|00287|binding|INFO|Removing iface tap46687852-4a ovn-installed in OVS
2026-06-22T14:28:43.919Z|00288|binding|INFO|Releasing lport 3f984367-01ca-4ee8-81af-034f1b621992 from this chassis (sb_readonly=0)
2026-06-22T14:28:43.919Z|00289|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 down in Southbound
2026-06-22T14:28:43.921Z|00290|binding|INFO|Removing iface tap3f984367-01 ovn-installed in OVS
2026-06-22T14:28:45.368Z|00291|binding|INFO|Claiming lport cr-lrp-a143b96e-39ea-46c6-bf2e-17092460e59b for this chassis.
2026-06-22T14:28:45.369Z|00292|binding|INFO|cr-lrp-a143b96e-39ea-46c6-bf2e-17092460e59b: Claiming fa:16:3e:e5:0f:43 172.24.5.254/24 2001:db8::2ad/64
2026-06-22T14:28:45.381Z|00293|binding|INFO|Setting lport cr-lrp-a143b96e-39ea-46c6-bf2e-17092460e59b up in Southbound
2026-06-22T14:28:45.480Z|00294|binding|INFO|Claiming lport 3f984367-01ca-4ee8-81af-034f1b621992 for this chassis.
2026-06-22T14:28:45.480Z|00295|binding|INFO|3f984367-01ca-4ee8-81af-034f1b621992: Claiming fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:28:45.509Z|00296|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 up in Southbound
2026-06-22T14:28:45.512Z|00297|binding|INFO|Setting lport 3f984367-01ca-4ee8-81af-034f1b621992 ovn-installed in OVS
2026-06-22T14:28:49.927Z|00298|binding|INFO|Claiming lport 65d61e57-d00b-4c12-9d83-4536044317e3 for this chassis.
2026-06-22T14:28:49.927Z|00299|binding|INFO|65d61e57-d00b-4c12-9d83-4536044317e3: Claiming fa:16:3e:f6:64:ce 10.10.10.251
2026-06-22T14:28:50.028Z|00300|binding|INFO|Setting lport 65d61e57-d00b-4c12-9d83-4536044317e3 ovn-installed in OVS
2026-06-22T14:28:57.208Z|00020|timeval(ovn_pinctrl0)|WARN|Unreasonably long 3671ms poll interval (2ms user, 3148ms system)
2026-06-22T14:28:57.272Z|00021|timeval(ovn_pinctrl0)|WARN|faults: 195 minor, 1278 major
2026-06-22T14:28:57.406Z|00022|timeval(ovn_pinctrl0)|WARN|disk: 325256 reads, 0 writes
2026-06-22T14:28:57.581Z|00023|timeval(ovn_pinctrl0)|WARN|context switches: 1302 voluntary, 2605 involuntary
2026-06-22T14:28:58.434Z|00024|coverage(ovn_pinctrl0)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=e579b53d:
2026-06-22T14:28:58.881Z|00025|coverage(ovn_pinctrl0)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:28:59.341Z|00026|coverage(ovn_pinctrl0)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:28:59.762Z|00027|coverage(ovn_pinctrl0)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:29:00.069Z|00028|coverage(ovn_pinctrl0)|INFO|vconn_sent                47.2/sec    68.717/sec        3.6783/sec   total: 13242
2026-06-22T14:29:00.328Z|00029|coverage(ovn_pinctrl0)|INFO|vconn_received             2.2/sec     5.300/sec        0.2139/sec   total: 770
2026-06-22T14:29:00.505Z|00030|coverage(ovn_pinctrl0)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:29:00.721Z|00031|coverage(ovn_pinctrl0)|INFO|util_xalloc              6427.0/sec 32433.267/sec     1395.1003/sec   total: 5022377
2026-06-22T14:29:01.378Z|00032|coverage(ovn_pinctrl0)|INFO|long_poll_interval         0.0/sec     0.017/sec        0.0006/sec   total: 2
2026-06-22T14:29:01.768Z|00033|coverage(ovn_pinctrl0)|INFO|stream_open                0.0/sec     0.017/sec        0.0025/sec   total: 9
2026-06-22T14:29:02.442Z|00034|coverage(ovn_pinctrl0)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:29:03.339Z|00035|coverage(ovn_pinctrl0)|INFO|seq_change                18.8/sec    38.050/sec        1.8778/sec   total: 6764
2026-06-22T14:29:06.286Z|00036|coverage(ovn_pinctrl0)|INFO|rconn_sent                47.2/sec    68.717/sec        3.6772/sec   total: 13238
2026-06-22T14:29:11.797Z|00037|coverage(ovn_pinctrl0)|INFO|rconn_queued              47.2/sec    68.717/sec        3.6772/sec   total: 13238
2026-06-22T14:29:18.609Z|00038|coverage(ovn_pinctrl0)|INFO|poll_zero_timeout          0.4/sec     0.467/sec        0.0400/sec   total: 144
2026-06-22T14:29:25.519Z|00039|coverage(ovn_pinctrl0)|INFO|poll_create_node          52.4/sec   113.067/sec        5.6247/sec   total: 20257
2026-06-22T14:29:25.547Z|00040|coverage(ovn_pinctrl0)|INFO|txn_try_again              0.0/sec     0.017/sec        0.0006/sec   total: 2
2026-06-22T14:29:25.556Z|00041|coverage(ovn_pinctrl0)|INFO|txn_success                0.2/sec     1.033/sec        0.0422/sec   total: 152
2026-06-22T14:29:25.556Z|00042|coverage(ovn_pinctrl0)|INFO|txn_incomplete             1.8/sec     1.450/sec        0.0714/sec   total: 257
2026-06-22T14:29:25.556Z|00043|coverage(ovn_pinctrl0)|INFO|txn_unchanged              3.4/sec     9.900/sec        0.5206/sec   total: 1874
2026-06-22T14:29:25.556Z|00044|coverage(ovn_pinctrl0)|INFO|hmap_reserve              17.4/sec    40.383/sec        0.9342/sec   total: 3363
2026-06-22T14:29:25.556Z|00045|coverage(ovn_pinctrl0)|INFO|hmap_expand               79.6/sec   545.400/sec       22.8606/sec   total: 82298
2026-06-22T14:29:25.556Z|00046|coverage(ovn_pinctrl0)|INFO|hmap_pathological          5.4/sec    13.317/sec        0.6183/sec   total: 2226
2026-06-22T14:29:25.556Z|00047|coverage(ovn_pinctrl0)|INFO|miniflow_malloc          260.0/sec   932.817/sec       41.6889/sec   total: 150080
2026-06-22T14:29:25.556Z|00048|coverage(ovn_pinctrl0)|INFO|flow_extract               1.2/sec     0.500/sec        0.0083/sec   total: 30
2026-06-22T14:29:25.556Z|00049|coverage(ovn_pinctrl0)|INFO|physical_run               0.4/sec     0.267/sec        0.0256/sec   total: 92
2026-06-22T14:29:25.556Z|00050|coverage(ovn_pinctrl0)|INFO|pinctrl_total_pin_pkts     1.2/sec     0.500/sec        0.0083/sec   total: 30
2026-06-22T14:29:25.556Z|00051|coverage(ovn_pinctrl0)|INFO|pinctrl_notify_main_thread   1.2/sec     0.233/sec        0.0039/sec   total: 14
2026-06-22T14:29:25.556Z|00052|coverage(ovn_pinctrl0)|INFO|lflow_conj_free            0.0/sec     0.583/sec        0.0142/sec   total: 51
2026-06-22T14:29:25.556Z|00053|coverage(ovn_pinctrl0)|INFO|lflow_conj_alloc           0.0/sec     1.217/sec        0.0314/sec   total: 113
2026-06-22T14:29:25.556Z|00054|coverage(ovn_pinctrl0)|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:29:25.556Z|00055|coverage(ovn_pinctrl0)|INFO|lflow_cache_delete         0.0/sec    23.367/sec        1.2894/sec   total: 4642
2026-06-22T14:29:25.557Z|00056|coverage(ovn_pinctrl0)|INFO|lflow_cache_miss           7.0/sec    67.317/sec        3.2514/sec   total: 11705
2026-06-22T14:29:25.557Z|00057|coverage(ovn_pinctrl0)|INFO|lflow_cache_hit           21.6/sec   463.950/sec       19.1600/sec   total: 68976
2026-06-22T14:29:25.557Z|00058|coverage(ovn_pinctrl0)|INFO|lflow_cache_add            0.0/sec    21.783/sec        1.6786/sec   total: 6043
2026-06-22T14:29:25.557Z|00059|coverage(ovn_pinctrl0)|INFO|lflow_cache_free_matches   0.0/sec    17.150/sec        1.0831/sec   total: 3899
2026-06-22T14:29:25.557Z|00060|coverage(ovn_pinctrl0)|INFO|lflow_cache_free_expr      0.0/sec     6.217/sec        0.2064/sec   total: 743
2026-06-22T14:29:25.557Z|00061|coverage(ovn_pinctrl0)|INFO|lflow_cache_add_matches    0.0/sec    16.833/sec        1.1933/sec   total: 4296
2026-06-22T14:29:25.557Z|00062|coverage(ovn_pinctrl0)|INFO|lflow_cache_add_expr       0.0/sec     4.950/sec        0.4853/sec   total: 1747
2026-06-22T14:29:25.557Z|00063|coverage(ovn_pinctrl0)|INFO|consider_logical_flow      0.8/sec   155.967/sec        6.0231/sec   total: 21683
2026-06-22T14:29:25.557Z|00064|coverage(ovn_pinctrl0)|INFO|lflow_run                  0.0/sec     0.083/sec        0.0033/sec   total: 12
2026-06-22T14:29:25.557Z|00065|coverage(ovn_pinctrl0)|INFO|111 events never hit
2026-06-22T14:29:25.557Z|00066|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:25.562Z|00301|memory_trim|INFO|Detected inactivity (last active 39137 ms ago): trimming memory
2026-06-22T14:29:25.562Z|00067|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:29:25.562Z|00068|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:29:25.562Z|00069|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:29:25.562Z|00070|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:29:25.562Z|00071|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:29:25.563Z|00302|timeval|WARN|Unreasonably long 29761ms poll interval (0ms user, 21118ms system)
2026-06-22T14:29:25.563Z|00303|timeval|WARN|faults: 398 minor, 3681 major
2026-06-22T14:29:25.563Z|00304|timeval|WARN|disk: 948808 reads, 0 writes
2026-06-22T14:29:25.563Z|00305|timeval|WARN|context switches: 3769 voluntary, 20952 involuntary
2026-06-22T14:29:25.563Z|00306|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=19e65154:
2026-06-22T14:29:25.563Z|00307|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:29:25.563Z|00308|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:29:25.563Z|00309|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:29:25.563Z|00310|coverage|INFO|vconn_sent                 0.0/sec    30.283/sec        3.6783/sec   total: 13258
2026-06-22T14:29:25.563Z|00311|coverage|INFO|vconn_received             0.0/sec     2.733/sec        0.2139/sec   total: 785
2026-06-22T14:29:25.563Z|00312|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:29:25.563Z|00313|coverage|INFO|util_xalloc                0.2/sec 10917.517/sec     1395.1114/sec   total: 5023562
2026-06-22T14:29:25.563Z|00314|coverage|INFO|long_poll_interval         0.0/sec     0.000/sec        0.0006/sec   total: 3
2026-06-22T14:29:25.563Z|00315|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0025/sec   total: 9
2026-06-22T14:29:25.563Z|00316|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:29:25.563Z|00317|coverage|INFO|seq_change                 0.2/sec    20.433/sec        1.8806/sec   total: 6782
2026-06-22T14:29:25.563Z|00318|coverage|INFO|rconn_sent                 0.0/sec    30.283/sec        3.6772/sec   total: 13254
2026-06-22T14:29:25.563Z|00319|coverage|INFO|rconn_queued               0.0/sec    30.283/sec        3.6772/sec   total: 13254
2026-06-22T14:29:25.563Z|00320|coverage|INFO|poll_zero_timeout          0.0/sec     0.200/sec        0.0400/sec   total: 144
2026-06-22T14:29:25.563Z|00321|coverage|INFO|poll_create_node           0.4/sec    59.433/sec        5.6303/sec   total: 20281
2026-06-22T14:29:25.563Z|00322|coverage|INFO|txn_try_again              0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:29:25.563Z|00323|coverage|INFO|txn_success                0.0/sec     0.567/sec        0.0422/sec   total: 152
2026-06-22T14:29:25.563Z|00324|coverage|INFO|txn_incomplete             0.0/sec     0.833/sec        0.0714/sec   total: 258
2026-06-22T14:29:25.563Z|00325|coverage|INFO|txn_unchanged              0.0/sec     4.967/sec        0.5206/sec   total: 1875
2026-06-22T14:29:25.563Z|00326|coverage|INFO|hmap_reserve               0.0/sec    19.767/sec        0.9342/sec   total: 3370
2026-06-22T14:29:25.563Z|00327|coverage|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0000/sec   total: 1
2026-06-22T14:29:25.563Z|00328|coverage|INFO|hmap_expand                0.0/sec   173.150/sec       22.8606/sec   total: 82314
2026-06-22T14:29:25.563Z|00329|coverage|INFO|hmap_pathological          0.0/sec     5.767/sec        0.6183/sec   total: 2228
2026-06-22T14:29:25.563Z|00330|coverage|INFO|miniflow_malloc            0.0/sec   308.683/sec       41.6889/sec   total: 150080
2026-06-22T14:29:25.563Z|00331|coverage|INFO|flow_extract               0.0/sec     0.433/sec        0.0083/sec   total: 45
2026-06-22T14:29:25.563Z|00332|coverage|INFO|physical_run               0.0/sec     0.133/sec        0.0256/sec   total: 92
2026-06-22T14:29:25.563Z|00333|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.433/sec        0.0083/sec   total: 45
2026-06-22T14:29:25.563Z|00334|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.233/sec        0.0039/sec   total: 24
2026-06-22T14:29:25.563Z|00335|coverage|INFO|lflow_conj_free            0.0/sec     0.350/sec        0.0142/sec   total: 51
2026-06-22T14:29:25.563Z|00336|coverage|INFO|lflow_conj_alloc           0.0/sec     0.450/sec        0.0314/sec   total: 113
2026-06-22T14:29:25.563Z|00337|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0006/sec   total: 3
2026-06-22T14:29:25.563Z|00338|coverage|INFO|lflow_cache_delete         0.0/sec     9.633/sec        1.2894/sec   total: 4642
2026-06-22T14:29:25.563Z|00339|coverage|INFO|lflow_cache_miss           0.0/sec    26.583/sec        3.2514/sec   total: 11705
2026-06-22T14:29:25.563Z|00340|coverage|INFO|lflow_cache_hit            0.0/sec   133.983/sec       19.1600/sec   total: 68976
2026-06-22T14:29:25.563Z|00341|coverage|INFO|lflow_cache_add            0.0/sec    10.233/sec        1.6786/sec   total: 6043
2026-06-22T14:29:25.563Z|00342|coverage|INFO|lflow_cache_free_matches   0.0/sec     7.783/sec        1.0831/sec   total: 3899
2026-06-22T14:29:25.563Z|00343|coverage|INFO|lflow_cache_free_expr      0.0/sec     1.850/sec        0.2064/sec   total: 743
2026-06-22T14:29:25.563Z|00344|coverage|INFO|lflow_cache_add_matches    0.0/sec     7.933/sec        1.1933/sec   total: 4296
2026-06-22T14:29:25.563Z|00345|coverage|INFO|lflow_cache_add_expr       0.0/sec     2.300/sec        0.4853/sec   total: 1747
2026-06-22T14:29:25.563Z|00346|coverage|INFO|consider_logical_flow      0.0/sec    37.100/sec        6.0231/sec   total: 21683
2026-06-22T14:29:25.563Z|00347|coverage|INFO|lflow_run                  0.0/sec     0.017/sec        0.0033/sec   total: 12
2026-06-22T14:29:25.563Z|00348|coverage|INFO|110 events never hit
2026-06-22T14:29:25.563Z|00349|poll_loop|INFO|wakeup due to [POLLIN] on fd 33 (FIFO pipe:[173405]) at controller/pinctrl.c:4177 (71% CPU usage)
2026-06-22T14:29:25.565Z|00350|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (71% CPU usage)
2026-06-22T14:29:25.565Z|00351|reconnect|ERR|ssl:10.4.3.247:6642: no response to inactivity probe after 33.4 seconds, disconnecting
2026-06-22T14:29:25.565Z|00352|reconnect|INFO|ssl:10.4.3.247:6642: connection dropped
2026-06-22T14:29:25.566Z|00072|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:25.566Z|00353|main|INFO|OVNSB commit failed, force recompute next time.
2026-06-22T14:29:25.566Z|00354|poll_loop|INFO|wakeup due to 0-ms timeout at lib/inc-proc-eng.c:66 (71% CPU usage)
2026-06-22T14:29:25.566Z|00355|poll_loop|INFO|wakeup due to 0-ms timeout at lib/inc-proc-eng.c:66 (71% CPU usage)
2026-06-22T14:29:25.567Z|00356|poll_loop|INFO|wakeup due to [POLLIN] on fd 33 (FIFO pipe:[173405]) at controller/pinctrl.c:4177 (71% CPU usage)
2026-06-22T14:29:25.567Z|00073|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:25.576Z|00074|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:25.577Z|00075|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:9f:09:1a 10.1.0.14
2026-06-22T14:29:26.345Z|00076|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:26.346Z|00357|poll_loop|INFO|wakeup due to [POLLIN] on fd 33 (FIFO pipe:[173405]) at controller/pinctrl.c:4177 (71% CPU usage)
2026-06-22T14:29:26.347Z|00077|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:26.364Z|00078|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:26.364Z|00358|poll_loop|INFO|wakeup due to [POLLIN] on fd 33 (FIFO pipe:[173405]) at controller/pinctrl.c:4177 (71% CPU usage)
2026-06-22T14:29:26.365Z|00079|poll_loop(ovn_pinctrl0)|INFO|wakeup due to [POLLIN] on fd 35 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (69% CPU usage)
2026-06-22T14:29:26.567Z|00359|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:29:27.116Z|00360|reconnect|INFO|ssl:10.4.3.247:6642: connected
2026-06-22T14:29:27.277Z|00361|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:29:27.277Z|00362|binding|INFO|Releasing lport 7ac297b0-bbb8-4c5e-8151-ef715500ed7b from this chassis (sb_readonly=0)
2026-06-22T14:29:27.277Z|00363|binding|INFO|Releasing lport 646abe0c-14de-4b92-b47b-40f7d2a6ad21 from this chassis (sb_readonly=0)
2026-06-22T14:29:27.277Z|00364|binding|INFO|Releasing lport 558029d3-5ac0-4a0a-9899-6731a664f339 from this chassis (sb_readonly=0)
2026-06-22T14:29:27.277Z|00365|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:29:27.313Z|00366|binding|INFO|Setting lport 65d61e57-d00b-4c12-9d83-4536044317e3 up in Southbound
2026-06-22T14:29:28.819Z|00367|binding|INFO|Releasing lport 92376ecf-f80b-4906-b717-642fa7e8d2a5 from this chassis (sb_readonly=0)
2026-06-22T14:29:28.949Z|00368|binding|INFO|Releasing lport f444f5b3-705c-4592-9c51-5c18bba97079 from this chassis (sb_readonly=0)
2026-06-22T14:29:28.950Z|00369|binding|INFO|Setting lport f444f5b3-705c-4592-9c51-5c18bba97079 down in Southbound
2026-06-22T14:29:28.954Z|00370|binding|INFO|Removing iface tapf444f5b3-70 ovn-installed in OVS
2026-06-22T14:29:28.996Z|00371|binding|INFO|Releasing lport 65d61e57-d00b-4c12-9d83-4536044317e3 from this chassis (sb_readonly=0)
2026-06-22T14:29:28.996Z|00372|binding|INFO|Setting lport 65d61e57-d00b-4c12-9d83-4536044317e3 down in Southbound
2026-06-22T14:29:28.999Z|00373|binding|INFO|Removing iface tap65d61e57-d0 ovn-installed in OVS
2026-06-22T14:29:34.262Z|00374|binding|INFO|Releasing lport 2a62f043-fb1b-435e-a232-99e4f8d0395b from this chassis (sb_readonly=0)
2026-06-22T14:29:34.262Z|00375|binding|INFO|Setting lport 2a62f043-fb1b-435e-a232-99e4f8d0395b down in Southbound
2026-06-22T14:29:34.289Z|00376|binding|INFO|Removing iface tap2a62f043-fb ovn-installed in OVS
2026-06-22T14:29:42.665Z|00377|timeval|WARN|Unreasonably long 3344ms poll interval (9ms user, 2635ms system)
2026-06-22T14:29:42.666Z|00378|timeval|WARN|faults: 371 minor, 3030 major
2026-06-22T14:29:42.666Z|00379|timeval|WARN|disk: 771296 reads, 0 writes
2026-06-22T14:29:42.666Z|00380|timeval|WARN|context switches: 3065 voluntary, 539 involuntary
2026-06-22T14:29:42.666Z|00381|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=6f7598ae:
2026-06-22T14:29:42.666Z|00382|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:29:42.666Z|00383|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:29:42.666Z|00384|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:29:42.666Z|00385|coverage|INFO|vconn_sent                14.2/sec    21.600/sec        3.8156/sec   total: 13736
2026-06-22T14:29:42.666Z|00386|coverage|INFO|vconn_received             3.6/sec     2.933/sec        0.2372/sec   total: 857
2026-06-22T14:29:42.666Z|00387|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:29:42.666Z|00388|coverage|INFO|util_xalloc              4916.6/sec 10855.450/sec     1503.2747/sec   total: 5415696
2026-06-22T14:29:42.666Z|00389|coverage|INFO|long_poll_interval         0.0/sec     0.033/sec        0.0011/sec   total: 4
2026-06-22T14:29:42.666Z|00390|coverage|INFO|stream_open                0.0/sec     0.017/sec        0.0028/sec   total: 10
2026-06-22T14:29:42.666Z|00391|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:29:42.666Z|00392|coverage|INFO|seq_change                 9.8/sec    20.450/sec        2.0147/sec   total: 7264
2026-06-22T14:29:42.666Z|00393|coverage|INFO|rconn_sent                14.2/sec    21.600/sec        3.8144/sec   total: 13732
2026-06-22T14:29:42.666Z|00394|coverage|INFO|rconn_queued              14.2/sec    21.600/sec        3.8144/sec   total: 13732
2026-06-22T14:29:42.666Z|00395|coverage|INFO|poll_zero_timeout          0.4/sec     0.333/sec        0.0433/sec   total: 157
2026-06-22T14:29:42.666Z|00396|coverage|INFO|poll_create_node          38.0/sec    57.783/sec        6.0022/sec   total: 21652
2026-06-22T14:29:42.666Z|00397|coverage|INFO|txn_try_again              0.0/sec     0.017/sec        0.0008/sec   total: 3
2026-06-22T14:29:42.666Z|00398|coverage|INFO|txn_success                0.4/sec     0.550/sec        0.0458/sec   total: 167
2026-06-22T14:29:42.666Z|00399|coverage|INFO|txn_incomplete             0.8/sec     0.883/sec        0.0769/sec   total: 283
2026-06-22T14:29:42.666Z|00400|coverage|INFO|txn_unchanged              4.4/sec     4.500/sec        0.5481/sec   total: 1975
2026-06-22T14:29:42.666Z|00401|coverage|INFO|hmap_reserve              16.8/sec    19.183/sec        1.0644/sec   total: 3852
2026-06-22T14:29:42.666Z|00402|coverage|INFO|hmap_shrink                0.0/sec     0.017/sec        0.0003/sec   total: 1
2026-06-22T14:29:42.666Z|00403|coverage|INFO|hmap_expand               82.8/sec   185.617/sec       24.8592/sec   total: 89562
2026-06-22T14:29:42.666Z|00404|coverage|INFO|hmap_pathological          5.2/sec     4.950/sec        0.6547/sec   total: 2365
2026-06-22T14:29:42.666Z|00405|coverage|INFO|miniflow_malloc           10.8/sec   216.650/sec       43.5347/sec   total: 156725
2026-06-22T14:29:42.666Z|00406|coverage|INFO|flow_extract               0.0/sec     0.867/sec        0.0172/sec   total: 62
2026-06-22T14:29:42.666Z|00407|coverage|INFO|physical_run               0.0/sec     0.083/sec        0.0261/sec   total: 94
2026-06-22T14:29:42.666Z|00408|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.867/sec        0.0172/sec   total: 62
2026-06-22T14:29:42.666Z|00409|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.667/sec        0.0111/sec   total: 40
2026-06-22T14:29:42.666Z|00410|coverage|INFO|lflow_conj_free            0.2/sec     0.233/sec        0.0153/sec   total: 55
2026-06-22T14:29:42.666Z|00411|coverage|INFO|lflow_conj_alloc           0.0/sec     0.317/sec        0.0342/sec   total: 123
2026-06-22T14:29:42.666Z|00412|coverage|INFO|lflow_cache_trim           0.0/sec     0.017/sec        0.0008/sec   total: 3
2026-06-22T14:29:42.666Z|00413|coverage|INFO|lflow_cache_delete         0.0/sec     4.533/sec        1.2906/sec   total: 4646
2026-06-22T14:29:42.666Z|00414|coverage|INFO|lflow_cache_miss           6.4/sec    17.333/sec        3.3536/sec   total: 12073
2026-06-22T14:29:42.666Z|00415|coverage|INFO|lflow_cache_hit            0.8/sec    97.717/sec       20.0883/sec   total: 72318
2026-06-22T14:29:42.666Z|00416|coverage|INFO|lflow_cache_add            0.0/sec     5.817/sec        1.6958/sec   total: 6105
2026-06-22T14:29:42.666Z|00417|coverage|INFO|lflow_cache_free_matches   0.0/sec     4.100/sec        1.0836/sec   total: 3901
2026-06-22T14:29:42.666Z|00418|coverage|INFO|lflow_cache_free_expr      0.0/sec     0.433/sec        0.2069/sec   total: 745
2026-06-22T14:29:42.666Z|00419|coverage|INFO|lflow_cache_add_matches    0.0/sec     4.350/sec        1.1961/sec   total: 4306
2026-06-22T14:29:42.666Z|00420|coverage|INFO|lflow_cache_add_expr       0.0/sec     1.467/sec        0.4997/sec   total: 1799
2026-06-22T14:29:42.666Z|00421|coverage|INFO|consider_logical_flow      4.2/sec    33.667/sec        6.4725/sec   total: 23301
2026-06-22T14:29:42.666Z|00422|coverage|INFO|lflow_run                  0.0/sec     0.017/sec        0.0036/sec   total: 13
2026-06-22T14:29:42.666Z|00423|coverage|INFO|110 events never hit
2026-06-22T14:29:42.666Z|00424|poll_loop|INFO|Dropped 28 log messages in last 16 seconds (most recently, 14 seconds ago) due to excessive rate
2026-06-22T14:29:42.666Z|00425|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (80% CPU usage)
2026-06-22T14:29:42.671Z|00426|reconnect|ERR|ssl:10.4.3.247:6642: no response to inactivity probe after 8.37 seconds, disconnecting
2026-06-22T14:29:42.671Z|00427|reconnect|INFO|ssl:10.4.3.247:6642: connection dropped
2026-06-22T14:29:42.684Z|00428|main|INFO|OVNSB commit failed, force recompute next time.
2026-06-22T14:29:42.691Z|00429|poll_loop|INFO|wakeup due to 0-ms timeout at lib/inc-proc-eng.c:66 (80% CPU usage)
2026-06-22T14:29:43.692Z|00430|poll_loop|INFO|Dropped 4 log messages in last 1 seconds (most recently, 1 seconds ago) due to excessive rate
2026-06-22T14:29:43.744Z|00431|poll_loop|INFO|wakeup due to 594-ms timeout at lib/reconnect.c:677 (80% CPU usage)
2026-06-22T14:29:43.939Z|00432|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:29:45.705Z|00433|reconnect|INFO|ssl:10.4.3.247:6642: connection attempt timed out
2026-06-22T14:29:45.809Z|00434|reconnect|INFO|ssl:10.4.3.247:6642: waiting 2 seconds before reconnect
2026-06-22T14:29:47.081Z|00435|timeval|WARN|Unreasonably long 1815ms poll interval (5ms user, 1540ms system)
2026-06-22T14:29:47.081Z|00436|timeval|WARN|faults: 101 minor, 954 major
2026-06-22T14:29:47.081Z|00437|timeval|WARN|disk: 247160 reads, 16 writes
2026-06-22T14:29:47.081Z|00438|timeval|WARN|context switches: 960 voluntary, 826 involuntary
2026-06-22T14:29:47.679Z|00439|reconnect|INFO|ssl:10.4.3.247:6642: connecting...
2026-06-22T14:29:47.683Z|00440|reconnect|INFO|ssl:10.4.3.247:6642: connected
2026-06-22T14:29:47.744Z|00441|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:29:47.744Z|00442|binding|INFO|Releasing lport 7ac297b0-bbb8-4c5e-8151-ef715500ed7b from this chassis (sb_readonly=0)
2026-06-22T14:29:47.744Z|00443|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:29:49.577Z|00444|poll_loop|INFO|Dropped 22 log messages in last 5 seconds (most recently, 2 seconds ago) due to excessive rate
2026-06-22T14:29:49.577Z|00445|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (65% CPU usage)
2026-06-22T14:30:05.000Z|00446|timeval|WARN|Unreasonably long 10167ms poll interval (8ms user, 9467ms system)
2026-06-22T14:30:05.000Z|00447|timeval|WARN|faults: 204 minor, 1687 major
2026-06-22T14:30:05.000Z|00448|timeval|WARN|disk: 455712 reads, 0 writes
2026-06-22T14:30:05.000Z|00449|timeval|WARN|context switches: 1705 voluntary, 7873 involuntary
2026-06-22T14:30:05.000Z|00450|poll_loop|INFO|Dropped 2 log messages in last 15 seconds (most recently, 15 seconds ago) due to excessive rate
2026-06-22T14:30:05.000Z|00451|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (93% CPU usage)
2026-06-22T14:30:05.253Z|00452|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (93% CPU usage)
2026-06-22T14:30:15.428Z|00453|timeval|WARN|Unreasonably long 1682ms poll interval (2ms user, 1143ms system)
2026-06-22T14:30:15.429Z|00454|timeval|WARN|faults: 21 minor, 104 major
2026-06-22T14:30:15.429Z|00455|timeval|WARN|disk: 23464 reads, 0 writes
2026-06-22T14:30:15.429Z|00456|timeval|WARN|context switches: 104 voluntary, 1229 involuntary
2026-06-22T14:30:39.485Z|00080|timeval(ovn_pinctrl0)|WARN|Unreasonably long 6042ms poll interval (1ms user, 4002ms system)
2026-06-22T14:30:39.491Z|00081|timeval(ovn_pinctrl0)|WARN|faults: 56 minor, 473 major
2026-06-22T14:30:39.491Z|00082|timeval(ovn_pinctrl0)|WARN|disk: 124616 reads, 0 writes
2026-06-22T14:30:39.491Z|00083|timeval(ovn_pinctrl0)|WARN|context switches: 482 voluntary, 3664 involuntary
2026-06-22T14:30:39.491Z|00084|coverage(ovn_pinctrl0)|INFO|Dropped 3 log messages in last 53 seconds (most recently, 24 seconds ago) due to excessive rate
2026-06-22T14:30:39.491Z|00004|timeval(ovn_statctrl3)|WARN|Unreasonably long 8136ms poll interval (0ms user, 3197ms system)
2026-06-22T14:30:39.491Z|00005|timeval(ovn_statctrl3)|WARN|faults: 27 minor, 223 major
2026-06-22T14:30:39.491Z|00006|timeval(ovn_statctrl3)|WARN|disk: 55000 reads, 0 writes
2026-06-22T14:30:39.491Z|00007|timeval(ovn_statctrl3)|WARN|context switches: 233 voluntary, 3632 involuntary
2026-06-22T14:30:39.492Z|00085|coverage(ovn_pinctrl0)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=34b8acff:
2026-06-22T14:30:39.492Z|00086|coverage(ovn_pinctrl0)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:30:39.492Z|00087|coverage(ovn_pinctrl0)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:30:39.492Z|00088|coverage(ovn_pinctrl0)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:30:39.492Z|00089|coverage(ovn_pinctrl0)|INFO|vconn_sent                 0.6/sec     8.617/sec        3.9394/sec   total: 14182
2026-06-22T14:30:39.492Z|00090|coverage(ovn_pinctrl0)|INFO|vconn_received             0.6/sec     0.717/sec        0.2442/sec   total: 879
2026-06-22T14:30:39.492Z|00091|coverage(ovn_pinctrl0)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:30:39.492Z|00092|coverage(ovn_pinctrl0)|INFO|util_xalloc                8.8/sec  6126.233/sec     1598.5500/sec   total: 5754828
2026-06-22T14:30:39.492Z|00093|coverage(ovn_pinctrl0)|INFO|long_poll_interval         0.0/sec     0.067/sec        0.0022/sec   total: 8
2026-06-22T14:30:39.492Z|00094|coverage(ovn_pinctrl0)|INFO|stream_open                0.0/sec     0.033/sec        0.0033/sec   total: 12
2026-06-22T14:30:39.492Z|00095|coverage(ovn_pinctrl0)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:30:39.492Z|00096|coverage(ovn_pinctrl0)|INFO|seq_change                 0.6/sec     5.183/sec        2.0875/sec   total: 7527
2026-06-22T14:30:39.492Z|00097|coverage(ovn_pinctrl0)|INFO|rconn_sent                 0.6/sec     8.617/sec        3.9383/sec   total: 14178
2026-06-22T14:30:39.492Z|00098|coverage(ovn_pinctrl0)|INFO|rconn_queued               0.6/sec     8.617/sec        3.9383/sec   total: 14178
2026-06-22T14:30:39.492Z|00099|coverage(ovn_pinctrl0)|INFO|poll_zero_timeout          0.0/sec     0.300/sec        0.0478/sec   total: 172
2026-06-22T14:30:39.492Z|00100|coverage(ovn_pinctrl0)|INFO|poll_create_node           1.6/sec    17.033/sec        6.2333/sec   total: 22464
2026-06-22T14:30:39.492Z|00101|coverage(ovn_pinctrl0)|INFO|txn_try_again              0.0/sec     0.017/sec        0.0011/sec   total: 4
2026-06-22T14:30:39.492Z|00102|coverage(ovn_pinctrl0)|INFO|txn_success                0.0/sec     0.100/sec        0.0469/sec   total: 169
2026-06-22T14:30:39.492Z|00103|coverage(ovn_pinctrl0)|INFO|txn_incomplete             0.0/sec     0.233/sec        0.0797/sec   total: 287
2026-06-22T14:30:39.492Z|00104|coverage(ovn_pinctrl0)|INFO|txn_unchanged              0.0/sec     1.633/sec        0.5692/sec   total: 2049
2026-06-22T14:30:39.492Z|00105|coverage(ovn_pinctrl0)|INFO|hmap_reserve               0.0/sec     5.183/sec        1.1275/sec   total: 4059
2026-06-22T14:30:39.492Z|00106|coverage(ovn_pinctrl0)|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:30:39.492Z|00107|coverage(ovn_pinctrl0)|INFO|hmap_expand                0.0/sec   114.783/sec       26.6572/sec   total: 95966
2026-06-22T14:30:39.492Z|00108|coverage(ovn_pinctrl0)|INFO|hmap_pathological          0.0/sec     1.900/sec        0.6792/sec   total: 2445
2026-06-22T14:30:39.492Z|00109|coverage(ovn_pinctrl0)|INFO|miniflow_malloc            0.0/sec   106.983/sec       45.3028/sec   total: 163090
2026-06-22T14:30:39.492Z|00110|coverage(ovn_pinctrl0)|INFO|flow_extract               0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:30:39.492Z|00111|coverage(ovn_pinctrl0)|INFO|physical_run               0.0/sec     0.017/sec        0.0264/sec   total: 95
2026-06-22T14:30:39.492Z|00112|coverage(ovn_pinctrl0)|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:30:39.492Z|00113|coverage(ovn_pinctrl0)|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0111/sec   total: 40
2026-06-22T14:30:39.492Z|00114|coverage(ovn_pinctrl0)|INFO|lflow_conj_free            0.0/sec     0.017/sec        0.0153/sec   total: 55
2026-06-22T14:30:39.492Z|00115|coverage(ovn_pinctrl0)|INFO|lflow_conj_alloc           0.0/sec     0.100/sec        0.0358/sec   total: 129
2026-06-22T14:30:39.492Z|00116|coverage(ovn_pinctrl0)|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:30:39.492Z|00117|coverage(ovn_pinctrl0)|INFO|lflow_cache_delete         0.0/sec     3.183/sec        1.3436/sec   total: 4837
2026-06-22T14:30:39.492Z|00118|coverage(ovn_pinctrl0)|INFO|lflow_cache_miss           0.0/sec     8.133/sec        3.4803/sec   total: 12529
2026-06-22T14:30:39.492Z|00119|coverage(ovn_pinctrl0)|INFO|lflow_cache_hit            0.0/sec    65.150/sec       21.1731/sec   total: 76223
2026-06-22T14:30:39.492Z|00120|coverage(ovn_pinctrl0)|INFO|lflow_cache_add            0.0/sec     2.050/sec        1.7300/sec   total: 6228
2026-06-22T14:30:39.492Z|00121|coverage(ovn_pinctrl0)|INFO|lflow_cache_free_matches   0.0/sec     2.033/sec        1.1175/sec   total: 4023
2026-06-22T14:30:39.492Z|00122|coverage(ovn_pinctrl0)|INFO|lflow_cache_free_expr      0.0/sec     1.150/sec        0.2261/sec   total: 814
2026-06-22T14:30:39.492Z|00123|coverage(ovn_pinctrl0)|INFO|lflow_cache_add_matches    0.0/sec     1.900/sec        1.2278/sec   total: 4420
2026-06-22T14:30:39.492Z|00124|coverage(ovn_pinctrl0)|INFO|lflow_cache_add_expr       0.0/sec     0.150/sec        0.5022/sec   total: 1808
2026-06-22T14:30:39.492Z|00125|coverage(ovn_pinctrl0)|INFO|consider_logical_flow      0.0/sec    28.100/sec        6.9350/sec   total: 24966
2026-06-22T14:30:39.492Z|00126|coverage(ovn_pinctrl0)|INFO|lflow_run                  0.0/sec     0.017/sec        0.0039/sec   total: 14
2026-06-22T14:30:39.492Z|00127|coverage(ovn_pinctrl0)|INFO|110 events never hit
2026-06-22T14:30:39.493Z|00457|memory_trim|INFO|Detected inactivity (last active 31291 ms ago): trimming memory
2026-06-22T14:30:39.493Z|00458|timeval|WARN|Unreasonably long 16499ms poll interval (3ms user, 9287ms system)
2026-06-22T14:30:39.493Z|00459|timeval|WARN|faults: 171 minor, 1682 major
2026-06-22T14:30:39.493Z|00460|timeval|WARN|disk: 448656 reads, 0 writes
2026-06-22T14:30:39.493Z|00461|timeval|WARN|context switches: 1705 voluntary, 8632 involuntary
2026-06-22T14:30:39.493Z|00462|poll_loop|INFO|Dropped 5 log messages in last 34 seconds (most recently, 34 seconds ago) due to excessive rate
2026-06-22T14:30:39.493Z|00463|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (56% CPU usage)
2026-06-22T14:30:39.495Z|00464|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (56% CPU usage)
2026-06-22T14:30:39.495Z|00465|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (56% CPU usage)
2026-06-22T14:30:39.496Z|00466|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (56% CPU usage)
2026-06-22T14:30:41.577Z|00467|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (56% CPU usage)
2026-06-22T14:30:41.581Z|00468|poll_loop|INFO|wakeup due to [POLLIN] on fd 28 (<->/var/run/openvswitch/db.sock) at lib/stream-fd.c:157 (56% CPU usage)
2026-06-22T14:30:57.378Z|00469|timeval|WARN|Unreasonably long 10633ms poll interval (0ms user, 9411ms system)
2026-06-22T14:30:57.378Z|00470|timeval|WARN|faults: 42 minor, 461 major
2026-06-22T14:30:57.378Z|00471|timeval|WARN|disk: 117952 reads, 0 writes
2026-06-22T14:30:57.378Z|00472|timeval|WARN|context switches: 471 voluntary, 9488 involuntary
2026-06-22T14:30:57.378Z|00473|poll_loop|INFO|Dropped 1 log messages in last 16 seconds (most recently, 16 seconds ago) due to excessive rate
2026-06-22T14:30:57.378Z|00474|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (89% CPU usage)
2026-06-22T14:30:57.379Z|00475|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (89% CPU usage)
2026-06-22T14:30:57.379Z|00476|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (89% CPU usage)
2026-06-22T14:31:29.737Z|00477|timeval|WARN|Unreasonably long 23844ms poll interval (5ms user, 22646ms system)
2026-06-22T14:31:29.737Z|00478|timeval|WARN|faults: 218 minor, 2207 major
2026-06-22T14:31:29.737Z|00479|timeval|WARN|disk: 596928 reads, 0 writes
2026-06-22T14:31:29.737Z|00480|timeval|WARN|context switches: 2239 voluntary, 20674 involuntary
2026-06-22T14:31:29.737Z|00481|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (95% CPU usage)
2026-06-22T14:31:29.738Z|00482|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (95% CPU usage)
2026-06-22T14:31:29.738Z|00483|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (95% CPU usage)
2026-06-22T14:31:29.913Z|00484|poll_loop|INFO|wakeup due to [POLLIN] on fd 33 (FIFO pipe:[173405]) at controller/pinctrl.c:4177 (95% CPU usage)
2026-06-22T14:31:29.915Z|00485|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (95% CPU usage)
2026-06-22T14:31:30.823Z|00486|memory_trim|INFO|Detected inactivity (last active 30002 ms ago): trimming memory
2026-06-22T14:31:39.186Z|00487|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:31:39.187Z|00488|binding|INFO|Releasing lport 7ac297b0-bbb8-4c5e-8151-ef715500ed7b from this chassis (sb_readonly=0)
2026-06-22T14:31:39.187Z|00489|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:32:19.608Z|00490|timeval|WARN|Unreasonably long 23815ms poll interval (6ms user, 21965ms system)
2026-06-22T14:32:19.609Z|00491|timeval|WARN|faults: 126 minor, 1672 major
2026-06-22T14:32:19.609Z|00492|timeval|WARN|disk: 442472 reads, 0 writes
2026-06-22T14:32:19.609Z|00493|timeval|WARN|context switches: 1704 voluntary, 20131 involuntary
2026-06-22T14:32:19.609Z|00494|coverage|INFO|Dropped 4 log messages in last 100 seconds (most recently, 50 seconds ago) due to excessive rate
2026-06-22T14:32:19.609Z|00495|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=ead30909:
2026-06-22T14:32:19.609Z|00496|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:32:19.609Z|00497|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:32:19.609Z|00498|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:32:19.609Z|00499|coverage|INFO|vconn_sent                 2.6/sec     9.833/sec        4.1069/sec   total: 14785
2026-06-22T14:32:19.609Z|00500|coverage|INFO|vconn_received             0.6/sec     0.400/sec        0.2511/sec   total: 907
2026-06-22T14:32:19.609Z|00501|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:32:19.609Z|00502|coverage|INFO|util_xalloc              386.2/sec  3180.133/sec     1654.9894/sec   total: 5960239
2026-06-22T14:32:19.609Z|00503|coverage|INFO|long_poll_interval         0.0/sec     0.067/sec        0.0036/sec   total: 13
2026-06-22T14:32:19.609Z|00504|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0033/sec   total: 12
2026-06-22T14:32:19.609Z|00505|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:32:19.609Z|00506|coverage|INFO|seq_change                 2.2/sec     4.200/sec        2.1722/sec   total: 7823
2026-06-22T14:32:19.609Z|00507|coverage|INFO|rconn_sent                 2.6/sec     9.833/sec        4.1058/sec   total: 14781
2026-06-22T14:32:19.609Z|00508|coverage|INFO|rconn_queued               2.6/sec     9.833/sec        4.1058/sec   total: 14781
2026-06-22T14:32:19.609Z|00509|coverage|INFO|poll_zero_timeout          0.4/sec     0.150/sec        0.0511/sec   total: 185
2026-06-22T14:32:19.609Z|00510|coverage|INFO|poll_create_node           5.6/sec    12.500/sec        6.4903/sec   total: 23389
2026-06-22T14:32:19.609Z|00511|coverage|INFO|txn_try_again              0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:32:19.609Z|00512|coverage|INFO|txn_success                0.4/sec     0.067/sec        0.0489/sec   total: 176
2026-06-22T14:32:19.609Z|00513|coverage|INFO|txn_incomplete             0.2/sec     0.083/sec        0.0825/sec   total: 297
2026-06-22T14:32:19.609Z|00514|coverage|INFO|txn_unchanged              1.4/sec     1.283/sec        0.5953/sec   total: 2149
2026-06-22T14:32:19.609Z|00515|coverage|INFO|hmap_reserve               1.2/sec     2.733/sec        1.1853/sec   total: 4279
2026-06-22T14:32:19.609Z|00516|coverage|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:32:19.609Z|00517|coverage|INFO|hmap_expand                7.6/sec    61.217/sec       27.7414/sec   total: 99920
2026-06-22T14:32:19.609Z|00518|coverage|INFO|hmap_pathological          0.4/sec     1.117/sec        0.7014/sec   total: 2528
2026-06-22T14:32:19.609Z|00519|coverage|INFO|miniflow_malloc            2.8/sec    86.150/sec       46.7597/sec   total: 168335
2026-06-22T14:32:19.609Z|00520|coverage|INFO|flow_extract               0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:32:19.609Z|00521|coverage|INFO|physical_run               0.0/sec     0.017/sec        0.0267/sec   total: 96
2026-06-22T14:32:19.609Z|00522|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:32:19.609Z|00523|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0111/sec   total: 40
2026-06-22T14:32:19.609Z|00524|coverage|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0153/sec   total: 55
2026-06-22T14:32:19.609Z|00525|coverage|INFO|lflow_conj_alloc           0.0/sec     0.100/sec        0.0375/sec   total: 135
2026-06-22T14:32:19.609Z|00526|coverage|INFO|lflow_cache_trim           0.0/sec     0.017/sec        0.0014/sec   total: 5
2026-06-22T14:32:19.609Z|00527|coverage|INFO|lflow_cache_delete         1.8/sec     2.350/sec        1.3839/sec   total: 4982
2026-06-22T14:32:19.609Z|00528|coverage|INFO|lflow_cache_miss           1.8/sec     4.367/sec        3.5542/sec   total: 12795
2026-06-22T14:32:19.609Z|00529|coverage|INFO|lflow_cache_hit            1.8/sec    49.900/sec       22.0058/sec   total: 79221
2026-06-22T14:32:19.609Z|00530|coverage|INFO|lflow_cache_add            0.0/sec     0.183/sec        1.7331/sec   total: 6239
2026-06-22T14:32:19.609Z|00531|coverage|INFO|lflow_cache_free_matches   0.8/sec     0.483/sec        1.1256/sec   total: 4052
2026-06-22T14:32:19.609Z|00532|coverage|INFO|lflow_cache_free_expr      1.0/sec     1.867/sec        0.2583/sec   total: 930
2026-06-22T14:32:19.609Z|00533|coverage|INFO|lflow_cache_add_matches    0.0/sec     0.067/sec        1.2289/sec   total: 4424
2026-06-22T14:32:19.609Z|00534|coverage|INFO|lflow_cache_add_expr       0.0/sec     0.117/sec        0.5042/sec   total: 1815
2026-06-22T14:32:19.609Z|00535|coverage|INFO|consider_logical_flow      0.0/sec    22.633/sec        7.3122/sec   total: 26324
2026-06-22T14:32:19.609Z|00536|coverage|INFO|lflow_run                  0.0/sec     0.017/sec        0.0042/sec   total: 15
2026-06-22T14:32:19.609Z|00537|coverage|INFO|110 events never hit
2026-06-22T14:32:19.609Z|00538|poll_loop|INFO|Dropped 1 log messages in last 49 seconds (most recently, 49 seconds ago) due to excessive rate
2026-06-22T14:32:19.609Z|00539|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (92% CPU usage)
2026-06-22T14:32:19.609Z|00540|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (92% CPU usage)
2026-06-22T14:32:19.610Z|00541|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (92% CPU usage)
2026-06-22T14:32:20.783Z|00542|poll_loop|INFO|wakeup due to 1172-ms timeout at lib/memory-trim.c:98 (92% CPU usage)
2026-06-22T14:32:20.785Z|00543|memory_trim|INFO|Detected inactivity (last active 30006 ms ago): trimming memory
2026-06-22T14:32:22.044Z|00544|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (92% CPU usage)
2026-06-22T14:32:35.723Z|00128|timeval(ovn_pinctrl0)|WARN|Unreasonably long 4775ms poll interval (1ms user, 1416ms system)
2026-06-22T14:32:35.724Z|00129|timeval(ovn_pinctrl0)|WARN|faults: 9 minor, 63 major
2026-06-22T14:32:35.724Z|00130|timeval(ovn_pinctrl0)|WARN|disk: 15480 reads, 0 writes
2026-06-22T14:32:35.724Z|00131|timeval(ovn_pinctrl0)|WARN|context switches: 63 voluntary, 1713 involuntary
2026-06-22T14:32:35.724Z|00008|timeval(ovn_statctrl3)|WARN|Unreasonably long 8315ms poll interval (0ms user, 4085ms system)
2026-06-22T14:32:35.724Z|00009|timeval(ovn_statctrl3)|WARN|faults: 43 minor, 221 major
2026-06-22T14:32:35.724Z|00010|timeval(ovn_statctrl3)|WARN|disk: 55232 reads, 0 writes
2026-06-22T14:32:35.724Z|00011|timeval(ovn_statctrl3)|WARN|context switches: 229 voluntary, 4025 involuntary
2026-06-22T14:32:35.724Z|00012|poll_loop(ovn_statctrl3)|INFO|wakeup due to [POLLIN] on fd 36 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (51% CPU usage)
2026-06-22T14:32:35.733Z|00545|timeval|WARN|Unreasonably long 13689ms poll interval (7ms user, 8474ms system)
2026-06-22T14:32:35.733Z|00546|timeval|WARN|faults: 509 minor, 3015 major
2026-06-22T14:32:35.733Z|00547|timeval|WARN|disk: 737632 reads, 8 writes
2026-06-22T14:32:35.733Z|00548|timeval|WARN|context switches: 3055 voluntary, 7057 involuntary
2026-06-22T14:32:35.733Z|00549|poll_loop|INFO|wakeup due to [POLLIN] on fd 32 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (52% CPU usage)
2026-06-22T14:32:43.219Z|00550|binding|INFO|Releasing lport 236e90b2-b525-4ad9-b518-92e0987e88aa from this chassis (sb_readonly=0)
2026-06-22T14:32:43.219Z|00551|binding|INFO|Releasing lport 7ac297b0-bbb8-4c5e-8151-ef715500ed7b from this chassis (sb_readonly=0)
2026-06-22T14:32:43.219Z|00552|binding|INFO|Releasing lport 75bf5903-4d6e-4d03-9c03-548918d2c86a from this chassis (sb_readonly=0)
2026-06-22T14:33:13.488Z|00553|memory_trim|INFO|Detected inactivity (last active 30270 ms ago): trimming memory
2026-06-22T14:33:13.489Z|00554|timeval|WARN|Unreasonably long 20114ms poll interval (1ms user, 18455ms system)
2026-06-22T14:33:13.489Z|00555|timeval|WARN|faults: 205 minor, 2228 major
2026-06-22T14:33:13.489Z|00556|timeval|WARN|disk: 602256 reads, 8 writes
2026-06-22T14:33:13.489Z|00557|timeval|WARN|context switches: 2269 voluntary, 16565 involuntary
2026-06-22T14:33:13.489Z|00558|coverage|INFO|Dropped 3 log messages in last 38 seconds (most recently, 38 seconds ago) due to excessive rate
2026-06-22T14:33:13.489Z|00559|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=f9fb8f2f:
2026-06-22T14:33:13.489Z|00560|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:33:13.489Z|00561|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:33:13.489Z|00562|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:33:13.489Z|00563|coverage|INFO|vconn_sent                 0.0/sec     3.383/sec        4.1575/sec   total: 14968
2026-06-22T14:33:13.489Z|00564|coverage|INFO|vconn_received             0.6/sec     0.300/sec        0.2553/sec   total: 919
2026-06-22T14:33:13.489Z|00565|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:33:13.489Z|00566|coverage|INFO|util_xalloc              207.6/sec  2509.733/sec     1695.7467/sec   total: 6107767
2026-06-22T14:33:13.489Z|00567|coverage|INFO|long_poll_interval         0.0/sec     0.033/sec        0.0042/sec   total: 16
2026-06-22T14:33:13.489Z|00568|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0033/sec   total: 12
2026-06-22T14:33:13.489Z|00569|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:33:13.489Z|00570|coverage|INFO|seq_change                 1.6/sec     2.300/sec        2.2056/sec   total: 7945
2026-06-22T14:33:13.489Z|00571|coverage|INFO|rconn_sent                 0.0/sec     3.383/sec        4.1564/sec   total: 14964
2026-06-22T14:33:13.489Z|00572|coverage|INFO|rconn_queued               0.0/sec     3.383/sec        4.1564/sec   total: 14964
2026-06-22T14:33:13.489Z|00573|coverage|INFO|poll_zero_timeout          0.2/sec     0.133/sec        0.0528/sec   total: 192
2026-06-22T14:33:13.489Z|00574|coverage|INFO|poll_create_node           4.0/sec     6.983/sec        6.5925/sec   total: 23768
2026-06-22T14:33:13.489Z|00575|coverage|INFO|txn_try_again              0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:33:13.489Z|00576|coverage|INFO|txn_success                0.2/sec     0.067/sec        0.0494/sec   total: 178
2026-06-22T14:33:13.489Z|00577|coverage|INFO|txn_incomplete             0.2/sec     0.050/sec        0.0831/sec   total: 299
2026-06-22T14:33:13.489Z|00578|coverage|INFO|txn_unchanged              0.6/sec     0.817/sec        0.6064/sec   total: 2191
2026-06-22T14:33:13.489Z|00579|coverage|INFO|hmap_reserve               1.6/sec     1.600/sec        1.2086/sec   total: 4367
2026-06-22T14:33:13.489Z|00580|coverage|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:33:13.489Z|00581|coverage|INFO|hmap_expand                4.8/sec    50.183/sec       28.5575/sec   total: 102877
2026-06-22T14:33:13.489Z|00582|coverage|INFO|hmap_pathological          0.6/sec     0.633/sec        0.7108/sec   total: 2563
2026-06-22T14:33:13.489Z|00583|coverage|INFO|miniflow_malloc            0.0/sec    75.667/sec       48.0133/sec   total: 172848
2026-06-22T14:33:13.489Z|00584|coverage|INFO|flow_extract               0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:33:13.489Z|00585|coverage|INFO|physical_run               0.0/sec     0.017/sec        0.0269/sec   total: 97
2026-06-22T14:33:13.489Z|00586|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:33:13.489Z|00587|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0111/sec   total: 40
2026-06-22T14:33:13.489Z|00588|coverage|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0153/sec   total: 55
2026-06-22T14:33:13.489Z|00589|coverage|INFO|lflow_conj_alloc           0.0/sec     0.100/sec        0.0392/sec   total: 141
2026-06-22T14:33:13.489Z|00590|coverage|INFO|lflow_cache_trim           0.0/sec     0.017/sec        0.0017/sec   total: 7
2026-06-22T14:33:13.489Z|00591|coverage|INFO|lflow_cache_delete         0.0/sec     1.283/sec        1.4017/sec   total: 5046
2026-06-22T14:33:13.489Z|00592|coverage|INFO|lflow_cache_miss           0.0/sec     3.217/sec        3.6042/sec   total: 12975
2026-06-22T14:33:13.489Z|00593|coverage|INFO|lflow_cache_hit            0.0/sec    46.300/sec       22.7739/sec   total: 81986
2026-06-22T14:33:13.489Z|00594|coverage|INFO|lflow_cache_add            0.0/sec     0.150/sec        1.7356/sec   total: 6248
2026-06-22T14:33:13.489Z|00595|coverage|INFO|lflow_cache_free_matches   0.0/sec     0.267/sec        1.1289/sec   total: 4064
2026-06-22T14:33:13.489Z|00596|coverage|INFO|lflow_cache_free_expr      0.0/sec     1.017/sec        0.2728/sec   total: 982
2026-06-22T14:33:13.489Z|00597|coverage|INFO|lflow_cache_add_matches    0.0/sec     0.067/sec        1.2300/sec   total: 4428
2026-06-22T14:33:13.489Z|00598|coverage|INFO|lflow_cache_add_expr       0.0/sec     0.083/sec        0.5056/sec   total: 1820
2026-06-22T14:33:13.489Z|00599|coverage|INFO|consider_logical_flow      0.0/sec    21.050/sec        7.6631/sec   total: 27587
2026-06-22T14:33:13.489Z|00600|coverage|INFO|lflow_run                  0.0/sec     0.017/sec        0.0044/sec   total: 16
2026-06-22T14:33:13.489Z|00601|coverage|INFO|110 events never hit
2026-06-22T14:33:13.489Z|00602|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (92% CPU usage)
2026-06-22T14:33:13.500Z|00603|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (92% CPU usage)
2026-06-22T14:33:13.501Z|00604|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (92% CPU usage)
2026-06-22T14:33:39.054Z|00013|timeval(ovn_statctrl3)|WARN|Unreasonably long 6558ms poll interval (1ms user, 3035ms system)
2026-06-22T14:33:39.055Z|00014|timeval(ovn_statctrl3)|WARN|faults: 14 minor, 175 major
2026-06-22T14:33:39.055Z|00015|timeval(ovn_statctrl3)|WARN|disk: 44824 reads, 0 writes
2026-06-22T14:33:39.055Z|00016|timeval(ovn_statctrl3)|WARN|context switches: 180 voluntary, 3473 involuntary
2026-06-22T14:33:39.055Z|00017|coverage(ovn_statctrl3)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=08dbd1c0:
2026-06-22T14:33:39.055Z|00018|coverage(ovn_statctrl3)|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:33:39.055Z|00019|coverage(ovn_statctrl3)|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:33:39.055Z|00020|coverage(ovn_statctrl3)|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:33:39.055Z|00021|coverage(ovn_statctrl3)|INFO|vconn_sent                 0.4/sec     3.117/sec        4.1589/sec   total: 14972
2026-06-22T14:33:39.055Z|00022|coverage(ovn_statctrl3)|INFO|vconn_received             0.4/sec     0.283/sec        0.2564/sec   total: 923
2026-06-22T14:33:39.055Z|00023|coverage(ovn_statctrl3)|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:33:39.055Z|00024|coverage(ovn_statctrl3)|INFO|util_xalloc              312.0/sec  2542.333/sec     1698.3956/sec   total: 6114300
2026-06-22T14:33:39.055Z|00025|coverage(ovn_statctrl3)|INFO|long_poll_interval         0.2/sec     0.083/sec        0.0050/sec   total: 18
2026-06-22T14:33:39.055Z|00026|coverage(ovn_statctrl3)|INFO|stream_open                0.0/sec     0.000/sec        0.0033/sec   total: 12
2026-06-22T14:33:39.055Z|00027|coverage(ovn_statctrl3)|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:33:39.055Z|00028|coverage(ovn_statctrl3)|INFO|seq_change                 0.8/sec     2.550/sec        2.2208/sec   total: 8014
2026-06-22T14:33:39.055Z|00029|coverage(ovn_statctrl3)|INFO|rconn_sent                 0.4/sec     3.117/sec        4.1578/sec   total: 14968
2026-06-22T14:33:39.055Z|00030|coverage(ovn_statctrl3)|INFO|rconn_queued               0.4/sec     3.117/sec        4.1578/sec   total: 14968
2026-06-22T14:33:39.055Z|00031|coverage(ovn_statctrl3)|INFO|poll_zero_timeout          0.2/sec     0.200/sec        0.0544/sec   total: 196
2026-06-22T14:33:39.055Z|00032|coverage(ovn_statctrl3)|INFO|poll_create_node           4.0/sec     7.950/sec        6.6433/sec   total: 23954
2026-06-22T14:33:39.055Z|00033|coverage(ovn_statctrl3)|INFO|txn_try_again              0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:33:39.055Z|00034|coverage(ovn_statctrl3)|INFO|txn_success                0.0/sec     0.033/sec        0.0494/sec   total: 178
2026-06-22T14:33:39.055Z|00035|coverage(ovn_statctrl3)|INFO|txn_incomplete             0.0/sec     0.033/sec        0.0831/sec   total: 299
2026-06-22T14:33:39.055Z|00036|coverage(ovn_statctrl3)|INFO|txn_unchanged              0.8/sec     0.933/sec        0.6131/sec   total: 2207
2026-06-22T14:33:39.055Z|00037|coverage(ovn_statctrl3)|INFO|hmap_reserve               1.6/sec     1.900/sec        1.2219/sec   total: 4399
2026-06-22T14:33:39.055Z|00038|coverage(ovn_statctrl3)|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:33:39.055Z|00039|coverage(ovn_statctrl3)|INFO|hmap_expand                7.0/sec    51.133/sec       28.6158/sec   total: 103017
2026-06-22T14:33:39.055Z|00040|coverage(ovn_statctrl3)|INFO|hmap_pathological          0.4/sec     0.700/sec        0.7142/sec   total: 2571
2026-06-22T14:33:39.055Z|00041|coverage(ovn_statctrl3)|INFO|miniflow_malloc            0.0/sec    75.217/sec       48.0133/sec   total: 172848
2026-06-22T14:33:39.055Z|00042|coverage(ovn_statctrl3)|INFO|flow_extract               0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:33:39.055Z|00043|coverage(ovn_statctrl3)|INFO|physical_run               0.0/sec     0.017/sec        0.0269/sec   total: 97
2026-06-22T14:33:39.055Z|00044|coverage(ovn_statctrl3)|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:33:39.055Z|00045|coverage(ovn_statctrl3)|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0111/sec   total: 40
2026-06-22T14:33:39.055Z|00046|coverage(ovn_statctrl3)|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0153/sec   total: 55
2026-06-22T14:33:39.055Z|00047|coverage(ovn_statctrl3)|INFO|lflow_conj_alloc           0.0/sec     0.100/sec        0.0392/sec   total: 141
2026-06-22T14:33:39.055Z|00048|coverage(ovn_statctrl3)|INFO|lflow_cache_trim           0.0/sec     0.033/sec        0.0019/sec   total: 7
2026-06-22T14:33:39.055Z|00049|coverage(ovn_statctrl3)|INFO|lflow_cache_delete         0.0/sec     1.067/sec        1.4017/sec   total: 5046
2026-06-22T14:33:39.055Z|00050|coverage(ovn_statctrl3)|INFO|lflow_cache_miss           0.0/sec     3.000/sec        3.6042/sec   total: 12975
2026-06-22T14:33:39.055Z|00051|coverage(ovn_statctrl3)|INFO|lflow_cache_hit            0.0/sec    46.083/sec       22.7739/sec   total: 81986
2026-06-22T14:33:39.055Z|00052|coverage(ovn_statctrl3)|INFO|lflow_cache_add            0.0/sec     0.150/sec        1.7356/sec   total: 6248
2026-06-22T14:33:39.055Z|00053|coverage(ovn_statctrl3)|INFO|lflow_cache_free_matches   0.0/sec     0.200/sec        1.1289/sec   total: 4064
2026-06-22T14:33:39.055Z|00054|coverage(ovn_statctrl3)|INFO|lflow_cache_free_expr      0.0/sec     0.867/sec        0.2728/sec   total: 982
2026-06-22T14:33:39.055Z|00055|coverage(ovn_statctrl3)|INFO|lflow_cache_add_matches    0.0/sec     0.067/sec        1.2300/sec   total: 4428
2026-06-22T14:33:39.055Z|00056|coverage(ovn_statctrl3)|INFO|lflow_cache_add_expr       0.0/sec     0.083/sec        0.5056/sec   total: 1820
2026-06-22T14:33:39.055Z|00057|coverage(ovn_statctrl3)|INFO|consider_logical_flow      0.0/sec    21.050/sec        7.6631/sec   total: 27587
2026-06-22T14:33:39.055Z|00058|coverage(ovn_statctrl3)|INFO|lflow_run                  0.0/sec     0.017/sec        0.0044/sec   total: 16
2026-06-22T14:33:39.055Z|00059|coverage(ovn_statctrl3)|INFO|110 events never hit
2026-06-22T14:33:39.057Z|00605|timeval|WARN|Unreasonably long 5981ms poll interval (1ms user, 3945ms system)
2026-06-22T14:33:39.057Z|00606|timeval|WARN|faults: 23 minor, 217 major
2026-06-22T14:33:39.057Z|00607|timeval|WARN|disk: 53864 reads, 0 writes
2026-06-22T14:33:39.057Z|00608|timeval|WARN|context switches: 222 voluntary, 4417 involuntary
2026-06-22T14:33:39.057Z|00609|poll_loop|INFO|wakeup due to [POLLIN] on fd 33 (FIFO pipe:[173405]) at controller/pinctrl.c:4177 (73% CPU usage)
2026-06-22T14:33:39.061Z|00610|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (73% CPU usage)
2026-06-22T14:33:39.062Z|00611|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (73% CPU usage)
2026-06-22T14:33:39.941Z|00612|poll_loop|INFO|wakeup due to [POLLIN] on fd 30 (<->/var/run/openvswitch/br-int.mgmt) at lib/stream-fd.c:157 (73% CPU usage)
2026-06-22T14:33:49.594Z|00613|timeval|WARN|Unreasonably long 6287ms poll interval (2ms user, 6049ms system)
2026-06-22T14:33:49.596Z|00614|timeval|WARN|faults: 58 minor, 658 major
2026-06-22T14:33:49.596Z|00615|timeval|WARN|disk: 165776 reads, 0 writes
2026-06-22T14:33:49.596Z|00616|timeval|WARN|context switches: 675 voluntary, 5822 involuntary
2026-06-22T14:33:49.596Z|00617|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (97% CPU usage)
2026-06-22T14:33:49.599Z|00618|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (97% CPU usage)
2026-06-22T14:33:49.601Z|00619|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (97% CPU usage)
2026-06-22T14:33:49.601Z|00620|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (97% CPU usage)
2026-06-22T14:34:14.644Z|00621|timeval|WARN|Unreasonably long 1801ms poll interval (1ms user, 1200ms system)
2026-06-22T14:34:14.644Z|00622|timeval|WARN|faults: 19 minor, 51 major
2026-06-22T14:34:14.644Z|00623|timeval|WARN|disk: 11304 reads, 0 writes
2026-06-22T14:34:14.644Z|00624|timeval|WARN|context switches: 57 voluntary, 1292 involuntary
2026-06-22T14:34:51.895Z|00625|timeval|WARN|Unreasonably long 8541ms poll interval (0ms user, 8076ms system)
2026-06-22T14:34:51.896Z|00626|timeval|WARN|faults: 45 minor, 469 major
2026-06-22T14:34:51.896Z|00627|timeval|WARN|disk: 123480 reads, 0 writes
2026-06-22T14:34:51.896Z|00628|timeval|WARN|context switches: 483 voluntary, 8652 involuntary
2026-06-22T14:34:51.896Z|00629|coverage|INFO|Dropped 3 log messages in last 73 seconds (most recently, 37 seconds ago) due to excessive rate
2026-06-22T14:34:51.896Z|00630|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour,  hash=b7f12d3b:
2026-06-22T14:34:51.896Z|00631|coverage|INFO|netlink_sent               0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:34:51.896Z|00632|coverage|INFO|netlink_recv_jumbo         0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:34:51.896Z|00633|coverage|INFO|netlink_received           0.0/sec     0.000/sec        0.0008/sec   total: 3
2026-06-22T14:34:51.896Z|00634|coverage|INFO|vconn_sent                 0.2/sec     0.100/sec        4.1608/sec   total: 14980
2026-06-22T14:34:51.896Z|00635|coverage|INFO|vconn_received             0.2/sec     0.100/sec        0.2583/sec   total: 931
2026-06-22T14:34:51.896Z|00636|coverage|INFO|vconn_open                 0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:34:51.896Z|00637|coverage|INFO|util_xalloc              314.4/sec   550.967/sec     1708.5819/sec   total: 6153963
2026-06-22T14:34:51.896Z|00638|coverage|INFO|long_poll_interval         0.0/sec     0.067/sec        0.0061/sec   total: 22
2026-06-22T14:34:51.896Z|00639|coverage|INFO|stream_open                0.0/sec     0.000/sec        0.0033/sec   total: 12
2026-06-22T14:34:51.896Z|00640|coverage|INFO|pstream_open               0.0/sec     0.000/sec        0.0003/sec   total: 1
2026-06-22T14:34:51.896Z|00641|coverage|INFO|seq_change                 2.4/sec     5.067/sec        2.3139/sec   total: 8334
2026-06-22T14:34:51.896Z|00642|coverage|INFO|rconn_sent                 0.2/sec     0.100/sec        4.1597/sec   total: 14976
2026-06-22T14:34:51.896Z|00643|coverage|INFO|rconn_queued               0.2/sec     0.100/sec        4.1597/sec   total: 14976
2026-06-22T14:34:51.896Z|00644|coverage|INFO|poll_zero_timeout          0.2/sec     0.350/sec        0.0606/sec   total: 220
2026-06-22T14:34:51.896Z|00645|coverage|INFO|poll_create_node           7.0/sec    14.183/sec        6.9042/sec   total: 24886
2026-06-22T14:34:51.896Z|00646|coverage|INFO|txn_try_again              0.0/sec     0.000/sec        0.0011/sec   total: 4
2026-06-22T14:34:51.896Z|00647|coverage|INFO|txn_success                0.0/sec     0.017/sec        0.0497/sec   total: 179
2026-06-22T14:34:51.896Z|00648|coverage|INFO|txn_incomplete             0.0/sec     0.017/sec        0.0836/sec   total: 301
2026-06-22T14:34:51.896Z|00649|coverage|INFO|txn_unchanged              0.8/sec     1.367/sec        0.6381/sec   total: 2305
2026-06-22T14:34:51.896Z|00650|coverage|INFO|hmap_reserve               1.6/sec     2.767/sec        1.2731/sec   total: 4599
2026-06-22T14:34:51.896Z|00651|coverage|INFO|hmap_shrink                0.0/sec     0.000/sec        0.0006/sec   total: 2
2026-06-22T14:34:51.896Z|00652|coverage|INFO|hmap_expand                7.0/sec    12.100/sec       28.8392/sec   total: 103891
2026-06-22T14:34:51.896Z|00653|coverage|INFO|hmap_pathological          0.4/sec     0.700/sec        0.7269/sec   total: 2621
2026-06-22T14:34:51.896Z|00654|coverage|INFO|miniflow_malloc            0.0/sec     0.000/sec       48.0133/sec   total: 172848
2026-06-22T14:34:51.896Z|00655|coverage|INFO|flow_extract               0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:34:51.896Z|00656|coverage|INFO|physical_run               0.0/sec     0.000/sec        0.0269/sec   total: 97
2026-06-22T14:34:51.896Z|00657|coverage|INFO|pinctrl_total_pin_pkts     0.0/sec     0.000/sec        0.0172/sec   total: 62
2026-06-22T14:34:51.896Z|00658|coverage|INFO|pinctrl_notify_main_thread   0.0/sec     0.000/sec        0.0111/sec   total: 40
2026-06-22T14:34:51.896Z|00659|coverage|INFO|lflow_conj_free            0.0/sec     0.000/sec        0.0153/sec   total: 55
2026-06-22T14:34:51.896Z|00660|coverage|INFO|lflow_conj_alloc           0.0/sec     0.000/sec        0.0392/sec   total: 141
2026-06-22T14:34:51.896Z|00661|coverage|INFO|lflow_cache_trim           0.0/sec     0.000/sec        0.0019/sec   total: 7
2026-06-22T14:34:51.896Z|00662|coverage|INFO|lflow_cache_delete         0.0/sec     0.000/sec        1.4017/sec   total: 5046
2026-06-22T14:34:51.896Z|00663|coverage|INFO|lflow_cache_miss           0.0/sec     0.000/sec        3.6042/sec   total: 12975
2026-06-22T14:34:51.896Z|00664|coverage|INFO|lflow_cache_hit            0.0/sec     0.000/sec       22.7739/sec   total: 81986
2026-06-22T14:34:51.896Z|00665|coverage|INFO|lflow_cache_add            0.0/sec     0.000/sec        1.7356/sec   total: 6248
2026-06-22T14:34:51.896Z|00666|coverage|INFO|lflow_cache_free_matches   0.0/sec     0.000/sec        1.1289/sec   total: 4064
2026-06-22T14:34:51.896Z|00667|coverage|INFO|lflow_cache_free_expr      0.0/sec     0.000/sec        0.2728/sec   total: 982
2026-06-22T14:34:51.896Z|00668|coverage|INFO|lflow_cache_add_matches    0.0/sec     0.000/sec        1.2300/sec   total: 4428
2026-06-22T14:34:51.896Z|00669|coverage|INFO|lflow_cache_add_expr       0.0/sec     0.000/sec        0.5056/sec   total: 1820
2026-06-22T14:34:51.896Z|00670|coverage|INFO|consider_logical_flow      0.0/sec     0.000/sec        7.6631/sec   total: 27587
2026-06-22T14:34:51.896Z|00671|coverage|INFO|lflow_run                  0.0/sec     0.000/sec        0.0044/sec   total: 16
2026-06-22T14:34:51.896Z|00672|coverage|INFO|110 events never hit
2026-06-22T14:34:51.896Z|00673|poll_loop|INFO|wakeup due to 0-ms timeout at lib/reconnect.c:677 (78% CPU usage)
2026-06-22T14:34:51.898Z|00674|poll_loop|INFO|wakeup due to [POLLIN] on fd 29 (10.4.3.247:37064<->10.4.3.247:6642) at lib/stream-ssl.c:842 (78% CPU usage)
2026-06-22T14:34:51.898Z|00675|poll_loop|INFO|wakeup due to 0-ms timeout at lib/stream-ssl.c:844 (78% CPU usage)