================== ovnkube.sh --- version: 3 ================ ==================== command: ovn-controller =================== hostname: instance =================== daemonset version 3 =============== ovn-controller - (wait for ovs) =============== ovn-controller - (wait for ready_to_start_node) ovn_nbdb= ovn_sbdb= error: subresource cannot be used when bulk resources are specified Getting the ovn-ovsdb-nb ep error: subresource cannot be used when bulk resources are specified Getting the ovn-ovsdb-sb ep ovn_nbdb=tcp://ovn-ovsdb-nb-0.ovn-ovsdb-nb.openstack.svc.cluster.local:6641 ovn_sbdb=tcp://ovn-ovsdb-sb-0.ovn-ovsdb-sb.openstack.svc.cluster.local:6642 ovn_nbdb tcp://ovn-ovsdb-nb-0.ovn-ovsdb-nb.openstack.svc.cluster.local:6641 ovn_sbdb tcp://ovn-ovsdb-sb-0.ovn-ovsdb-sb.openstack.svc.cluster.local:6642 ovn_nbdb_conn tcp:ovn-ovsdb-nb-0.ovn-ovsdb-nb.openstack.svc.cluster.local:6641 =============== ovn-controller start_controller chown: cannot access '/etc/openvswitch': No such file or directory chown: cannot access '/var/log/openvswitch': No such file or directory chown: cannot access '/etc/ovn': No such file or directory nice: cannot set niceness: Permission denied 2026-08-20T01:50:29Z|00001|vlog|INFO|opened log file /var/log/ovn/ovn-controller.log Starting ovn-controller. run as: setpriv --reuid 42424 --regid 42424 --groups 42424 /usr/share/ovn/scripts/ovn-ctl --no-monitor start_controller --ovn-controller-log=-vconsole:info -vfile:info =============== ovn-controller ========== running 2026-08-20T01:50:29.445Z|00014|ofctrl|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch 2026-08-20T01:50:29.445Z|00015|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting... 2026-08-20T01:50:29.445Z|00016|rconn|WARN|unix:/var/run/openvswitch/br-int.mgmt: connection failed (No such file or directory) 2026-08-20T01:50:29.445Z|00017|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: waiting 1 seconds before reconnect 2026-08-20T01:50:29.445Z|00018|reconnect|INFO|unix:/var/run/openvswitch/db.sock: connected 2026-08-20T01:50:29.446Z|00019|features|INFO|OVS DB schema supports 4 flow table prefixes, our IDL supports: 4 2026-08-20T01:50:29.446Z|00020|main|INFO|Setting flow table prefixes: ip_src, ip_dst, ipv6_src, ipv6_dst. 2026-08-20T01:50:29.449Z|00021|features|INFO|OVS Feature: ct_zero_snat, state: supported 2026-08-20T01:50:29.449Z|00022|features|INFO|OVS Feature: ct_flush, state: supported 2026-08-20T01:50:29.449Z|00023|main|INFO|OVS feature set changed, force recompute. 2026-08-20T01:50:30.446Z|00024|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting... 2026-08-20T01:50:30.447Z|00025|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected 2026-08-20T01:50:30.447Z|00026|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting... 2026-08-20T01:50:30.448Z|00027|main|INFO|OVS feature set changed, force recompute. 2026-08-20T01:50:30.449Z|00028|rconn|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected 2026-08-20T01:50:30.449Z|00029|main|INFO|OVS OpenFlow connection reconnected,force recompute. 2026-08-20T01:50:30.450Z|00001|pinctrl(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch 2026-08-20T01:50:30.450Z|00001|statctrl(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting to switch 2026-08-20T01:50:30.450Z|00002|rconn(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting... 2026-08-20T01:50:30.450Z|00002|rconn(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connecting... 2026-08-20T01:50:30.450Z|00003|rconn(ovn_pinctrl0)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected 2026-08-20T01:50:30.451Z|00003|rconn(ovn_statctrl3)|INFO|unix:/var/run/openvswitch/br-int.mgmt: connected 2026-08-20T01:50:40.459Z|00030|memory|INFO|13268 kB peak resident set size after 11.0 seconds 2026-08-20T01:50:40.459Z|00031|memory|INFO|idl-cells-OVN_Southbound:211 idl-cells-Open_vSwitch:186 ofctrl_desired_flow_usage-KB:4 ofctrl_installed_flow_usage-KB:3 ofctrl_sb_flow_ref_usage-KB:2 2026-08-20T01:59:33.694Z|00032|binding|INFO|Claiming lport 264eead9-c7b8-4c59-8778-9ac62b92aaea for this chassis. 2026-08-20T01:59:33.694Z|00033|binding|INFO|264eead9-c7b8-4c59-8778-9ac62b92aaea: Claiming fa:16:3e:cf:6d:2a 172.24.2.128 2026-08-20T01:59:33.740Z|00034|binding|INFO|Setting lport 264eead9-c7b8-4c59-8778-9ac62b92aaea ovn-installed in OVS 2026-08-20T01:59:33.740Z|00035|binding|INFO|Setting lport 264eead9-c7b8-4c59-8778-9ac62b92aaea up in Southbound 2026-08-20T01:59:34.963Z|00004|pinctrl(ovn_pinctrl0)|INFO|DHCPOFFER fa:16:3e:cf:6d:2a 172.24.2.128 2026-08-20T01:59:34.964Z|00005|pinctrl(ovn_pinctrl0)|INFO|DHCPACK fa:16:3e:cf:6d:2a 172.24.2.128 2026-08-20T01:59:37.704Z|00036|binding|INFO|Releasing lport 73acff54-b361-4df1-af4a-f5d35474fe57 from this chassis (sb_readonly=0) 2026-08-20T02:00:07.707Z|00037|memory_trim|INFO|Detected inactivity (last active 30003 ms ago): trimming memory 2026-08-20T02:07:19.789Z|00038|timeval|WARN|Unreasonably long 1750ms poll interval (27ms user, 0ms system) 2026-08-20T02:07:19.789Z|00039|timeval|WARN|context switches: 0 voluntary, 7 involuntary 2026-08-20T02:07:19.789Z|00040|coverage|INFO|Event coverage, avg rate over last: 5 seconds, last minute, last hour, hash=ba453c14: 2026-08-20T02:07:19.789Z|00041|coverage|INFO|lflow_run 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-08-20T02:07:19.789Z|00042|coverage|INFO|consider_logical_flow 0.0/sec 0.000/sec 0.0497/sec total: 179 2026-08-20T02:07:19.789Z|00043|coverage|INFO|lflow_cache_add_expr 0.0/sec 0.000/sec 0.0025/sec total: 9 2026-08-20T02:07:19.789Z|00044|coverage|INFO|lflow_cache_add_matches 0.0/sec 0.000/sec 0.0303/sec total: 109 2026-08-20T02:07:19.789Z|00045|coverage|INFO|lflow_cache_add 0.0/sec 0.000/sec 0.0328/sec total: 118 2026-08-20T02:07:19.789Z|00046|coverage|INFO|lflow_cache_hit 0.0/sec 0.000/sec 0.0022/sec total: 8 2026-08-20T02:07:19.789Z|00047|coverage|INFO|lflow_cache_miss 0.0/sec 0.000/sec 0.0492/sec total: 177 2026-08-20T02:07:19.789Z|00048|coverage|INFO|lflow_cache_trim 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-08-20T02:07:19.789Z|00049|coverage|INFO|lflow_conj_alloc 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-08-20T02:07:19.789Z|00050|coverage|INFO|lflow_conj_free 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-08-20T02:07:19.789Z|00051|coverage|INFO|pinctrl_total_pin_pkts 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-08-20T02:07:19.789Z|00052|coverage|INFO|physical_run 0.0/sec 0.000/sec 0.0011/sec total: 4 2026-08-20T02:07:19.789Z|00053|coverage|INFO|flow_extract 0.0/sec 0.000/sec 0.0006/sec total: 2 2026-08-20T02:07:19.789Z|00054|coverage|INFO|miniflow_malloc 0.0/sec 0.000/sec 0.2025/sec total: 729 2026-08-20T02:07:19.789Z|00055|coverage|INFO|hmap_pathological 0.0/sec 0.000/sec 0.0086/sec total: 31 2026-08-20T02:07:19.789Z|00056|coverage|INFO|hmap_expand 14.0/sec 7.700/sec 2.5461/sec total: 9166 2026-08-20T02:07:19.789Z|00057|coverage|INFO|hmap_reserve 1.6/sec 0.883/sec 0.1128/sec total: 406 2026-08-20T02:07:19.789Z|00058|coverage|INFO|txn_unchanged 3.2/sec 1.767/sec 0.4886/sec total: 1759 2026-08-20T02:07:19.789Z|00059|coverage|INFO|txn_incomplete 0.0/sec 0.000/sec 0.0069/sec total: 25 2026-08-20T02:07:19.789Z|00060|coverage|INFO|txn_success 0.0/sec 0.000/sec 0.0042/sec total: 15 2026-08-20T02:07:19.789Z|00061|coverage|INFO|poll_create_node 17.0/sec 14.550/sec 4.7969/sec total: 17269 2026-08-20T02:07:19.790Z|00062|coverage|INFO|poll_zero_timeout 0.4/sec 0.217/sec 0.0575/sec total: 207 2026-08-20T02:07:19.790Z|00063|coverage|INFO|rconn_queued 0.0/sec 0.067/sec 0.1047/sec total: 377 2026-08-20T02:07:19.790Z|00064|coverage|INFO|rconn_sent 0.0/sec 0.067/sec 0.1047/sec total: 377 2026-08-20T02:07:19.790Z|00065|coverage|INFO|seq_change 3.6/sec 4.533/sec 1.6342/sec total: 5883 2026-08-20T02:07:19.790Z|00066|coverage|INFO|pstream_open 0.0/sec 0.000/sec 0.0003/sec total: 1 2026-08-20T02:07:19.790Z|00067|coverage|INFO|stream_open 0.0/sec 0.000/sec 0.0025/sec total: 9 2026-08-20T02:07:19.790Z|00068|coverage|INFO|unixctl_received 0.2/sec 0.117/sec 0.0281/sec total: 101 2026-08-20T02:07:19.790Z|00069|coverage|INFO|unixctl_replied 0.2/sec 0.117/sec 0.0281/sec total: 101 2026-08-20T02:07:19.790Z|00070|coverage|INFO|util_xalloc 421.8/sec 242.950/sec 81.5725/sec total: 293661 2026-08-20T02:07:19.790Z|00071|coverage|INFO|vconn_open 0.0/sec 0.000/sec 0.0017/sec total: 6 2026-08-20T02:07:19.790Z|00072|coverage|INFO|vconn_received 0.0/sec 0.067/sec 0.0256/sec total: 92 2026-08-20T02:07:19.790Z|00073|coverage|INFO|vconn_sent 0.0/sec 0.067/sec 0.1058/sec total: 381 2026-08-20T02:07:19.790Z|00074|coverage|INFO|126 events never hit