+ COMMAND=start + OVS_SOCKET=/run/openvswitch/db.sock + OVS_PID=/run/openvswitch/ovs-vswitchd.pid + start + t=0 + '[' '!' -e /run/openvswitch/db.sock ']' + ovs-vsctl --db=unix:/run/openvswitch/db.sock --no-wait show 46cb457f-5567-42eb-a96d-0ba6189ff8a3 + exec ovsinit -- /usr/sbin/ovs-vswitchd unix:/run/openvswitch/db.sock -vconsole:emer -vconsole:err -vconsole:info --pidfile=/run/openvswitch/ovs-vswitchd.pid --user=openvswitch:openvswitch --mlockall time=2026-07-20T19:31:32.883Z level=INFO msg="no existing process found" binary=ovs-vswitchd time=2026-07-20T19:31:32.883Z level=INFO msg="claimed succession" binary=ovs-vswitchd pod=openvswitch-g8lgj time=2026-07-20T19:31:32.884Z level=INFO msg="starting process" binary=ovs-vswitchd 2026-07-20T19:31:33Z|00001|ovs_numa|INFO|Discovered 16 CPU cores on NUMA node 0 2026-07-20T19:31:33Z|00002|ovs_numa|INFO|Discovered 1 NUMA nodes and 16 CPU cores 2026-07-20T19:31:33Z|00003|reconnect|INFO|unix:/run/openvswitch/db.sock: connecting... 2026-07-20T19:31:33Z|00004|reconnect|INFO|unix:/run/openvswitch/db.sock: connected 2026-07-20T19:31:33Z|00005|dpdk|INFO|DPDK Disabled - Use other_config:dpdk-init to enable 2026-07-20T19:31:33Z|00006|bridge|INFO|ovs-vswitchd (Open vSwitch) 3.3.7 2026-07-20T19:31:43Z|00007|memory|INFO|317432 kB peak resident set size after 11.0 seconds 2026-07-20T19:31:43Z|00008|memory|INFO|idl-cells-Open_vSwitch:17 2026-07-20T19:39:59Z|00009|dpif_netlink|INFO|Datapath dispatch mode: per-cpu 2026-07-20T19:39:59Z|00010|ofproto_dpif|INFO|system@ovs-system: Datapath supports recirculation 2026-07-20T19:39:59Z|00011|ofproto_dpif|INFO|system@ovs-system: VLAN header stack length probed as 2 2026-07-20T19:39:59Z|00012|ofproto_dpif|INFO|system@ovs-system: MPLS label stack length probed as 3 2026-07-20T19:39:59Z|00013|ofproto_dpif|INFO|system@ovs-system: Datapath supports truncate action 2026-07-20T19:39:59Z|00014|ofproto_dpif|INFO|system@ovs-system: Datapath supports unique flow ids 2026-07-20T19:39:59Z|00015|ofproto_dpif|INFO|system@ovs-system: Datapath supports clone action 2026-07-20T19:39:59Z|00016|ofproto_dpif|INFO|system@ovs-system: Max sample nesting level probed as 10 2026-07-20T19:39:59Z|00017|ofproto_dpif|INFO|system@ovs-system: Datapath supports eventmask in conntrack action 2026-07-20T19:39:59Z|00018|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_clear action 2026-07-20T19:39:59Z|00019|ofproto_dpif|INFO|system@ovs-system: Max dp_hash algorithm probed to be 0 2026-07-20T19:39:59Z|00020|ofproto_dpif|INFO|system@ovs-system: Datapath supports check_pkt_len action 2026-07-20T19:39:59Z|00021|ofproto_dpif|INFO|system@ovs-system: Datapath supports timeout policy in conntrack action 2026-07-20T19:39:59Z|00022|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_zero_snat 2026-07-20T19:39:59Z|00023|ofproto_dpif|INFO|system@ovs-system: Datapath supports add_mpls action 2026-07-20T19:39:59Z|00024|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_state 2026-07-20T19:39:59Z|00025|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_zone 2026-07-20T19:39:59Z|00026|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_mark 2026-07-20T19:39:59Z|00027|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_label 2026-07-20T19:39:59Z|00028|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_state_nat 2026-07-20T19:39:59Z|00029|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_orig_tuple 2026-07-20T19:39:59Z|00030|ofproto_dpif|INFO|system@ovs-system: Datapath supports ct_orig_tuple6 2026-07-20T19:39:59Z|00031|ofproto_dpif|INFO|system@ovs-system: Datapath does not support IPv6 ND Extensions 2026-07-20T19:39:59Z|00032|ofproto_dpif_upcall|INFO|Overriding n-handler-threads to 16, setting n-revalidator-threads to 5 2026-07-20T19:39:59Z|00033|ofproto_dpif_upcall|INFO|Starting 21 threads 2026-07-20T19:39:59Z|00034|bridge|INFO|bridge br-ex: added interface br-ex on port 65534 2026-07-20T19:39:59Z|00035|bridge|INFO|bridge br-ex: using datapath ID 0000aae28ba7c644 2026-07-20T19:39:59Z|00036|connmgr|INFO|br-ex: added service controller "punix:/var/run/openvswitch/br-ex.mgmt" 2026-07-20T19:40:01Z|00037|bridge|INFO|bridge br-int: added interface br-int on port 65534 2026-07-20T19:40:01Z|00038|bridge|INFO|bridge br-int: using datapath ID 0000828006dd2907 2026-07-20T19:40:01Z|00039|connmgr|INFO|br-int: added service controller "punix:/var/run/openvswitch/br-int.mgmt" 2026-07-20T19:40:07Z|00040|memory|INFO|peak resident set size grew 57% in last 503.3 seconds, from 317432 kB to 498316 kB 2026-07-20T19:40:07Z|00041|memory|INFO|handlers:16 idl-cells-Open_vSwitch:186 ofconns:4 ports:2 revalidators:5 rules:26 2026-07-20T19:40:12Z|00042|connmgr|INFO|br-int<->unix#19: 18 flow_mods 10 s ago (17 adds, 1 deletes) 2026-07-20T19:52:23Z|00043|bridge|INFO|bridge br-int: added interface o-hm0 on port 1 2026-07-20T19:52:25Z|00044|bridge|INFO|bridge br-int: added interface tapc9795624-b0 on port 2 2026-07-20T19:52:33Z|00045|connmgr|INFO|br-int<->unix#19: 267 flow_mods in the 2 s starting 10 s ago (266 adds, 1 deletes) 2026-07-20T19:56:41Z|00001|timeval(revalidator18)|WARN|Unreasonably long 2908ms poll interval (3ms user, 5ms system) 2026-07-20T19:56:41Z|00002|timeval(revalidator18)|WARN|context switches: 0 voluntary, 19 involuntary 2026-07-20T19:56:41Z|00003|coverage(revalidator18)|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=e68dec9b: 2026-07-20T19:56:41Z|00004|coverage(revalidator18)|INFO|bridge_reconfigure 0.0/sec 0.133/sec 0.0747/sec total: 269 2026-07-20T19:56:41Z|00005|coverage(revalidator18)|INFO|ofproto_flush 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-07-20T19:56:41Z|00006|coverage(revalidator18)|INFO|ofproto_recv_openflow 0.0/sec 0.067/sec 0.1047/sec total: 377 2026-07-20T19:56:41Z|00007|coverage(revalidator18)|INFO|ofproto_update_port 0.0/sec 0.000/sec 0.0036/sec total: 13 2026-07-20T19:56:41Z|00008|coverage(revalidator18)|INFO|rev_reconfigure 0.0/sec 0.000/sec 0.0008/sec total: 3 2026-07-20T19:56:41Z|00009|coverage(revalidator18)|INFO|rev_port_toggled 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-07-20T19:56:41Z|00010|coverage(revalidator18)|INFO|rev_flow_table 0.0/sec 0.000/sec 0.0014/sec total: 5 2026-07-20T19:56:41Z|00011|coverage(revalidator18)|INFO|xlate_actions 0.0/sec 0.000/sec 0.0039/sec total: 14 2026-07-20T19:56:41Z|00012|coverage(revalidator18)|INFO|cmap_expand 0.0/sec 1.833/sec 1.0581/sec total: 3809 2026-07-20T19:56:41Z|00013|coverage(revalidator18)|INFO|cmap_shrink 0.0/sec 1.833/sec 0.9836/sec total: 3541 2026-07-20T19:56:41Z|00014|coverage(revalidator18)|INFO|dpif_execute 0.0/sec 0.000/sec 0.0028/sec total: 10 2026-07-20T19:56:41Z|00015|coverage(revalidator18)|INFO|dpif_execute_error 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-07-20T19:56:41Z|00016|coverage(revalidator18)|INFO|dpif_flow_del 0.0/sec 0.000/sec 0.0081/sec total: 29 2026-07-20T19:56:41Z|00017|coverage(revalidator18)|INFO|dpif_flow_flush 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-07-20T19:56:41Z|00018|coverage(revalidator18)|INFO|dpif_flow_get 0.0/sec 0.000/sec 0.0067/sec total: 24 2026-07-20T19:56:41Z|00019|coverage(revalidator18)|INFO|dpif_flow_put 0.0/sec 0.000/sec 0.0083/sec total: 30 2026-07-20T19:56:41Z|00020|coverage(revalidator18)|INFO|dpif_flow_put_error 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-07-20T19:56:41Z|00021|coverage(revalidator18)|INFO|dpif_port_add 0.0/sec 0.000/sec 0.0011/sec total: 4 2026-07-20T19:56:41Z|00022|coverage(revalidator18)|INFO|flow_extract 0.0/sec 0.000/sec 0.0042/sec total: 15 2026-07-20T19:56:41Z|00023|coverage(revalidator18)|INFO|miniflow_malloc 0.0/sec 31.433/sec 15.9097/sec total: 57275 2026-07-20T19:56:41Z|00024|coverage(revalidator18)|INFO|hindex_pathological 0.0/sec 0.000/sec 0.0017/sec total: 6 2026-07-20T19:56:41Z|00025|coverage(revalidator18)|INFO|hindex_expand 0.0/sec 0.000/sec 0.0017/sec total: 6 2026-07-20T19:56:41Z|00026|coverage(revalidator18)|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0033/sec total: 12 2026-07-20T19:56:41Z|00027|coverage(revalidator18)|INFO|hmap_expand 9.6/sec 18.833/sec 6.6661/sec total: 24004 2026-07-20T19:56:41Z|00028|coverage(revalidator18)|INFO|netdev_get_stats 0.8/sec 0.800/sec 0.1406/sec total: 506 2026-07-20T19:56:41Z|00029|coverage(revalidator18)|INFO|txn_unchanged 0.2/sec 0.567/sec 0.2567/sec total: 924 2026-07-20T19:56:41Z|00030|coverage(revalidator18)|INFO|txn_incomplete 0.0/sec 0.000/sec 0.0100/sec total: 36 2026-07-20T19:56:41Z|00031|coverage(revalidator18)|INFO|txn_success 0.0/sec 0.000/sec 0.0044/sec total: 16 2026-07-20T19:56:41Z|00032|coverage(revalidator18)|INFO|poll_create_node 112.8/sec 174.000/sec 53.2669/sec total: 191835 2026-07-20T19:56:41Z|00033|coverage(revalidator18)|INFO|poll_zero_timeout 0.0/sec 0.400/sec 0.1789/sec total: 644 2026-07-20T19:56:41Z|00034|coverage(revalidator18)|INFO|rconn_queued 0.0/sec 0.067/sec 0.0244/sec total: 88 2026-07-20T19:56:41Z|00035|coverage(revalidator18)|INFO|rconn_sent 0.0/sec 0.067/sec 0.0244/sec total: 88 2026-07-20T19:56:41Z|00036|coverage(revalidator18)|INFO|seq_change 805.2/sec 1142.167/sec 347.3125/sec total: 1250858 2026-07-20T19:56:41Z|00037|coverage(revalidator18)|INFO|pstream_open 0.0/sec 0.000/sec 0.0014/sec total: 5 2026-07-20T19:56:41Z|00038|coverage(revalidator18)|INFO|stream_open 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-07-20T19:56:41Z|00039|coverage(revalidator18)|INFO|unixctl_received 0.0/sec 0.050/sec 0.0186/sec total: 67 2026-07-20T19:56:41Z|00040|coverage(revalidator18)|INFO|unixctl_replied 0.0/sec 0.050/sec 0.0186/sec total: 67 2026-07-20T19:56:41Z|00041|coverage(revalidator18)|INFO|util_xalloc 233.0/sec 1031.067/sec 453.1061/sec total: 1631314 2026-07-20T19:56:41Z|00042|coverage(revalidator18)|INFO|vconn_received 0.0/sec 0.067/sec 0.1058/sec total: 381 2026-07-20T19:56:41Z|00043|coverage(revalidator18)|INFO|vconn_sent 0.0/sec 0.067/sec 0.0256/sec total: 92 2026-07-20T19:56:41Z|00044|coverage(revalidator18)|INFO|netdev_set_policing 0.0/sec 0.000/sec 0.0031/sec total: 11 2026-07-20T19:56:41Z|00045|coverage(revalidator18)|INFO|netdev_set_hwaddr 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-07-20T19:56:41Z|00046|coverage(revalidator18)|INFO|netdev_get_ethtool 0.0/sec 0.000/sec 0.0011/sec total: 4 2026-07-20T19:56:41Z|00047|coverage(revalidator18)|INFO|netdev_set_ethtool 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-07-20T19:56:41Z|00048|coverage(revalidator18)|INFO|netlink_received 7.4/sec 89.233/sec 43.1125/sec total: 155208 2026-07-20T19:56:41Z|00049|coverage(revalidator18)|INFO|netlink_recv_jumbo 0.2/sec 14.700/sec 7.1389/sec total: 25700 2026-07-20T19:56:41Z|00050|coverage(revalidator18)|INFO|netlink_sent 5.8/sec 85.417/sec 41.4542/sec total: 149238 2026-07-20T19:56:41Z|00051|coverage(revalidator18)|INFO|route_table_dump 0.0/sec 0.167/sec 0.0958/sec total: 345 2026-07-20T19:56:41Z|00052|coverage(revalidator18)|INFO|nln_changed 0.0/sec 0.433/sec 0.2511/sec total: 904 2026-07-20T19:56:41Z|00053|coverage(revalidator18)|INFO|131 events never hit 2026-07-20T20:03:36Z|00046|bridge|INFO|bridge br-int: added interface tap1f9b6ab2-37 on port 3 2026-07-20T20:03:46Z|00047|connmgr|INFO|br-int<->unix#19: 145 flow_mods in the 1 s starting 10 s ago (141 adds, 2 deletes, 2 modifications) 2026-07-20T20:21:43Z|00048|bridge|INFO|bridge br-ex: added interface patch-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb-to-br-int on port 1 2026-07-20T20:21:43Z|00049|bridge|INFO|bridge br-int: added interface patch-br-int-to-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb on port 4 2026-07-20T20:21:53Z|00050|connmgr|INFO|br-int<->unix#19: 1222 flow_mods in the 9 s starting 10 s ago (1190 adds, 22 deletes, 10 modifications) 2026-07-20T20:22:53Z|00051|connmgr|INFO|br-int<->unix#19: 4845 flow_mods in the 56 s starting 59 s ago (2288 adds, 2542 deletes, 15 modifications) 2026-07-20T20:23:13Z|00052|bridge|INFO|bridge br-ex: deleted interface patch-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb-to-br-int on port 1 2026-07-20T20:23:13Z|00053|bridge|INFO|bridge br-int: deleted interface patch-br-int-to-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb on port 4 2026-07-20T20:23:53Z|00054|connmgr|INFO|br-int<->unix#19: 1166 flow_mods in the 18 s starting 59 s ago (128 adds, 1038 deletes) 2026-07-20T20:24:23Z|00055|bridge|INFO|bridge br-ex: added interface patch-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb-to-br-int on port 2 2026-07-20T20:24:23Z|00056|bridge|INFO|bridge br-int: added interface patch-br-int-to-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb on port 5 2026-07-20T20:24:53Z|00057|connmgr|INFO|br-int<->unix#19: 1592 flow_mods in the 27 s starting 29 s ago (1454 adds, 123 deletes, 15 modifications) 2026-07-20T20:25:23Z|00058|bridge|INFO|bridge br-ex: deleted interface patch-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb-to-br-int on port 2 2026-07-20T20:25:23Z|00059|bridge|INFO|bridge br-int: deleted interface patch-br-int-to-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb on port 5 2026-07-20T20:25:53Z|00060|connmgr|INFO|br-int<->unix#19: 2165 flow_mods in the 30 s starting 59 s ago (417 adds, 1748 deletes) 2026-07-20T20:26:42Z|00061|bridge|INFO|bridge br-ex: added interface patch-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb-to-br-int on port 3 2026-07-20T20:26:42Z|00062|bridge|INFO|bridge br-int: added interface patch-br-int-to-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb on port 6 2026-07-20T20:26:53Z|00063|connmgr|INFO|br-int<->unix#19: 695 flow_mods in the 8 s starting 10 s ago (678 adds, 13 deletes, 4 modifications) 2026-07-20T20:27:19Z|00064|bridge|INFO|bridge br-ex: deleted interface patch-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb-to-br-int on port 3 2026-07-20T20:27:19Z|00065|bridge|INFO|bridge br-int: deleted interface patch-br-int-to-provnet-503863f7-6661-46ad-b027-f1ef6cab41cb on port 6 2026-07-20T20:27:53Z|00066|connmgr|INFO|br-int<->unix#19: 1233 flow_mods in the 25 s starting 59 s ago (284 adds, 949 deletes)