[ovs-discuss] ovs w dpdk live lock?

David Evans davidjoshuaevans at gmail.com
Fri Aug 24 21:37:35 UTC 2018


Dpdk 17.11.3
OVS 2.9.2
Kernel. 3.10.0-862.9.1.el7.x86_64

If i connect intel x553 dpdk 8086:15c4  to ovs bridge, but the ports are
down, or sfp not installed, this happens as below in the log
traffic through the 'up' port will incur massive latency (up to 3 or more
seconds)

'waiting for main to quiesce'

If i only add ports that are up, it works fine afaik.

2018-08-24T21:27:12.289Z|00001|vlog|INFO|opened log file
/var/log/openvswitch/vswitchd.log
2018-08-24T21:27:12.292Z|00002|ovs_numa|INFO|Discovered 16 CPU cores on
NUMA node 0
2018-08-24T21:27:12.292Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 16
CPU cores
2018-08-24T21:27:12.292Z|00004|reconnect|INFO|unix:/var/run/openvswitch/db.sock:
connecting...
2018-08-24T21:27:12.292Z|00005|reconnect|INFO|unix:/var/run/openvswitch/db.sock:
connected
2018-08-24T21:27:12.295Z|00006|dpdk|INFO|Using DPDK 17.11.0
2018-08-24T21:27:12.295Z|00007|dpdk|INFO|DPDK Enabled - initializing...
2018-08-24T21:27:12.295Z|00008|dpdk|INFO|No vhost-sock-dir provided -
defaulting to /var/run/openvswitch
2018-08-24T21:27:12.295Z|00009|dpdk|INFO|IOMMU support for
vhost-user-client disabled.
2018-08-24T21:27:12.295Z|00010|dpdk|INFO|EAL ARGS: ovs-vswitchd -c 0x1E
--socket-mem 512
2018-08-24T21:27:12.298Z|00011|dpdk|INFO|EAL: Detected 16 lcore(s)
2018-08-24T21:27:12.318Z|00012|dpdk|INFO|EAL: Probing VFIO support...
2018-08-24T21:27:13.207Z|00013|dpdk|INFO|EAL: PCI device 0000:02:00.0 on
NUMA socket -1
2018-08-24T21:27:13.207Z|00014|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.207Z|00015|dpdk|INFO|EAL:   probe driver: 8086:1533
net_e1000_igb
2018-08-24T21:27:13.207Z|00016|dpdk|INFO|EAL: PCI device 0000:03:00.0 on
NUMA socket -1
2018-08-24T21:27:13.207Z|00017|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.207Z|00018|dpdk|INFO|EAL:   probe driver: 8086:1533
net_e1000_igb
2018-08-24T21:27:13.207Z|00019|dpdk|INFO|EAL: PCI device 0000:04:00.0 on
NUMA socket -1
2018-08-24T21:27:13.207Z|00020|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.207Z|00021|dpdk|INFO|EAL:   probe driver: 8086:1533
net_e1000_igb
2018-08-24T21:27:13.250Z|00022|dpdk|INFO|EAL: PCI device 0000:05:00.0 on
NUMA socket -1
2018-08-24T21:27:13.250Z|00023|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.250Z|00024|dpdk|INFO|EAL:   probe driver: 8086:1533
net_e1000_igb
2018-08-24T21:27:13.292Z|00025|dpdk|INFO|EAL: PCI device 0000:06:00.0 on
NUMA socket -1
2018-08-24T21:27:13.292Z|00026|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.292Z|00027|dpdk|INFO|EAL:   probe driver: 8086:1521
net_e1000_igb
2018-08-24T21:27:13.356Z|00028|dpdk|INFO|EAL: PCI device 0000:06:00.1 on
NUMA socket -1
2018-08-24T21:27:13.356Z|00029|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.356Z|00030|dpdk|INFO|EAL:   probe driver: 8086:1521
net_e1000_igb
2018-08-24T21:27:13.420Z|00031|dpdk|INFO|EAL: PCI device 0000:06:00.2 on
NUMA socket -1
2018-08-24T21:27:13.420Z|00032|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.420Z|00033|dpdk|INFO|EAL:   probe driver: 8086:1521
net_e1000_igb
2018-08-24T21:27:13.482Z|00034|dpdk|INFO|EAL: PCI device 0000:06:00.3 on
NUMA socket -1
2018-08-24T21:27:13.482Z|00035|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.483Z|00036|dpdk|INFO|EAL:   probe driver: 8086:1521
net_e1000_igb
2018-08-24T21:27:13.545Z|00037|dpdk|INFO|EAL: PCI device 0000:0a:00.0 on
NUMA socket -1
2018-08-24T21:27:13.545Z|00038|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.545Z|00039|dpdk|INFO|EAL:   probe driver: 8086:15c4
net_ixgbe
2018-08-24T21:27:13.987Z|00040|dpdk|INFO|EAL: PCI device 0000:0a:00.1 on
NUMA socket -1
2018-08-24T21:27:13.987Z|00041|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:13.987Z|00042|dpdk|INFO|EAL:   probe driver: 8086:15c4
net_ixgbe
2018-08-24T21:27:14.419Z|00043|dpdk|INFO|EAL: PCI device 0000:0b:00.0 on
NUMA socket -1
2018-08-24T21:27:14.419Z|00044|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:14.419Z|00045|dpdk|INFO|EAL:   probe driver: 8086:15c4
net_ixgbe
2018-08-24T21:27:14.846Z|00046|dpdk|INFO|EAL: PCI device 0000:0b:00.1 on
NUMA socket -1
2018-08-24T21:27:14.846Z|00047|dpdk|WARN|EAL:   Invalid NUMA socket,
default to 0
2018-08-24T21:27:14.846Z|00048|dpdk|INFO|EAL:   probe driver: 8086:15c4
net_ixgbe
2018-08-24T21:27:15.283Z|00049|dpdk|INFO|DPDK pdump packet capture enabled
2018-08-24T21:27:15.283Z|00050|dpdk|INFO|DPDK Enabled - initialized
2018-08-24T21:27:15.285Z|00051|timeval|WARN|Unreasonably long 2991ms poll
interval (2047ms user, 941ms system)
2018-08-24T21:27:15.285Z|00052|timeval|WARN|faults: 887 minor, 0 major
2018-08-24T21:27:15.285Z|00053|timeval|WARN|disk: 0 reads, 8 writes
2018-08-24T21:27:15.285Z|00054|timeval|WARN|context switches: 3 voluntary,
178 involuntary
2018-08-24T21:27:15.285Z|00055|coverage|INFO|Event coverage, avg rate over
last: 5 seconds, last minute, last hour,  hash=8e477bb5:
2018-08-24T21:27:15.285Z|00056|coverage|INFO|bridge_reconfigure
 0.0/sec     0.000/sec        0.0000/sec   total: 1
2018-08-24T21:27:15.285Z|00057|coverage|INFO|cmap_expand
0.0/sec     0.000/sec        0.0000/sec   total: 9
2018-08-24T21:27:15.286Z|00058|coverage|INFO|miniflow_malloc
0.0/sec     0.000/sec        0.0000/sec   total: 11
2018-08-24T21:27:15.286Z|00059|coverage|INFO|hmap_expand
0.0/sec     0.000/sec        0.0000/sec   total: 398
2018-08-24T21:27:15.286Z|00060|coverage|INFO|txn_unchanged
0.0/sec     0.000/sec        0.0000/sec   total: 2
2018-08-24T21:27:15.286Z|00061|coverage|INFO|txn_incomplete
 0.0/sec     0.000/sec        0.0000/sec   total: 1
2018-08-24T21:27:15.286Z|00062|coverage|INFO|poll_create_node
 0.0/sec     0.000/sec        0.0000/sec   total: 47
2018-08-24T21:27:15.286Z|00063|coverage|INFO|poll_zero_timeout
0.0/sec     0.000/sec        0.0000/sec   total: 1
2018-08-24T21:27:15.286Z|00064|coverage|INFO|seq_change
 0.0/sec     0.000/sec        0.0000/sec   total: 53
2018-08-24T21:27:15.286Z|00065|coverage|INFO|pstream_open
 0.0/sec     0.000/sec        0.0000/sec   total: 1
2018-08-24T21:27:15.286Z|00066|coverage|INFO|stream_open
0.0/sec     0.000/sec        0.0000/sec   total: 1
2018-08-24T21:27:15.286Z|00067|coverage|INFO|util_xalloc
0.0/sec     0.000/sec        0.0000/sec   total: 7851
2018-08-24T21:27:15.286Z|00068|coverage|INFO|netdev_get_hwaddr
0.0/sec     0.000/sec        0.0000/sec   total: 3
2018-08-24T21:27:15.286Z|00069|coverage|INFO|netlink_received
 0.0/sec     0.000/sec        0.0000/sec   total: 3
2018-08-24T21:27:15.286Z|00070|coverage|INFO|netlink_sent
 0.0/sec     0.000/sec        0.0000/sec   total: 1
2018-08-24T21:27:15.286Z|00071|coverage|INFO|89 events never hit
2018-08-24T21:27:15.286Z|00072|bridge|INFO|ovs-vswitchd (Open vSwitch) 2.9.2
2018-08-24T21:27:27.358Z|00073|memory|INFO|4668 kB peak resident set size
after 15.1 seconds
2018-08-24T21:27:27.368Z|00074|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports recirculation
2018-08-24T21:27:27.368Z|00075|ofproto_dpif|INFO|netdev at ovs-netdev: VLAN
header stack length probed as 1
2018-08-24T21:27:27.368Z|00076|ofproto_dpif|INFO|netdev at ovs-netdev: MPLS
label stack length probed as 3
2018-08-24T21:27:27.368Z|00077|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports truncate action
2018-08-24T21:27:27.368Z|00078|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports unique flow ids
2018-08-24T21:27:27.368Z|00079|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports clone action
2018-08-24T21:27:27.369Z|00080|ofproto_dpif|INFO|netdev at ovs-netdev: Max
sample nesting level probed as 10
2018-08-24T21:27:27.369Z|00081|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports eventmask in conntrack action
2018-08-24T21:27:27.369Z|00082|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_clear action
2018-08-24T21:27:27.369Z|00083|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_state
2018-08-24T21:27:27.369Z|00084|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_zone
2018-08-24T21:27:27.369Z|00085|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_mark
2018-08-24T21:27:27.369Z|00086|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_label
2018-08-24T21:27:27.369Z|00087|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_state_nat
2018-08-24T21:27:27.369Z|00088|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_orig_tuple
2018-08-24T21:27:27.369Z|00089|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_orig_tuple6
2018-08-24T21:27:27.369Z|00090|bridge|INFO|bridge br0: added interface br0
on port 65534
2018-08-24T21:27:27.382Z|00091|bridge|INFO|bridge br0: using datapath ID
00009e03dd9e9b43
2018-08-24T21:27:27.383Z|00092|connmgr|INFO|br0: added service controller
"punix:/var/run/openvswitch/br0.mgmt"
2018-08-24T21:27:31.420Z|00093|connmgr|INFO|br0<->unix#1: 1 flow_mods in
the last 0 s (1 deletes)
2018-08-24T21:27:33.450Z|00094|dpif_netdev|INFO|PMD thread on numa_id: 0,
core id:  3 created.
2018-08-24T21:27:33.450Z|00095|dpif_netdev|INFO|PMD thread on numa_id: 0,
core id:  1 created.
2018-08-24T21:27:33.451Z|00096|dpif_netdev|INFO|PMD thread on numa_id: 0,
core id:  2 created.
2018-08-24T21:27:33.451Z|00097|dpif_netdev|INFO|PMD thread on numa_id: 0,
core id:  4 created.
2018-08-24T21:27:33.451Z|00098|dpif_netdev|INFO|There are 4 pmd threads on
numa node 0
2018-08-24T21:27:35.517Z|00099|dpdk|INFO|PMD:
ixgbe_dev_link_status_print():  Port 8: Link Down
2018-08-24T21:27:35.517Z|00100|netdev_dpdk|INFO|Port 8: 3c:2c:99:f8:80:ea
2018-08-24T21:27:37.212Z|00101|dpif_netdev|INFO|Core 3 on numa node 0
assigned port 'data_10g-2' rx queue 0 (measured processing cycles 0).
2018-08-24T21:27:37.212Z|00102|dpif_netdev|INFO|Core 2 on numa node 0
assigned port 'data_10g-2' rx queue 1 (measured processing cycles 0).
2018-08-24T21:27:38.059Z|00103|bridge|INFO|bridge br0: added interface
data_10g-2 on port 1
2018-08-24T21:27:39.426Z|00001|ovs_rcu(urcu2)|WARN|blocked 1000 ms waiting
for main to quiesce
2018-08-24T21:27:39.760Z|00104|bridge|INFO|bridge br0: using datapath ID
00003c2c99f880ea
2018-08-24T21:27:39.760Z|00105|timeval|WARN|Unreasonably long 6311ms poll
interval (5140ms user, 63ms system)
2018-08-24T21:27:39.760Z|00106|timeval|WARN|faults: 51 minor, 0 major
2018-08-24T21:27:39.760Z|00107|timeval|WARN|context switches: 4 voluntary,
20012 involuntary
2018-08-24T21:27:39.761Z|00108|coverage|INFO|Event coverage, avg rate over
last: 5 seconds, last minute, last hour,  hash=83188855:
2018-08-24T21:27:39.761Z|00109|coverage|INFO|bridge_reconfigure
 0.0/sec     0.067/sec        0.0011/sec   total: 5
2018-08-24T21:27:39.761Z|00110|coverage|INFO|ofproto_flush
0.0/sec     0.017/sec        0.0003/sec   total: 1
2018-08-24T21:27:39.761Z|00111|coverage|INFO|ofproto_recv_openflow
0.0/sec     0.050/sec        0.0008/sec   total: 3
2018-08-24T21:27:39.761Z|00112|coverage|INFO|ofproto_update_port
0.0/sec     0.050/sec        0.0008/sec   total: 4
2018-08-24T21:27:39.761Z|00113|coverage|INFO|rev_reconfigure
0.0/sec     0.067/sec        0.0011/sec   total: 5
2018-08-24T21:27:39.761Z|00114|coverage|INFO|rev_flow_table
 0.0/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:39.761Z|00115|coverage|INFO|xlate_actions
0.0/sec     0.167/sec        0.0028/sec   total: 10
2018-08-24T21:27:39.761Z|00116|coverage|INFO|cmap_expand
0.0/sec     1.217/sec        0.0203/sec   total: 73
2018-08-24T21:27:39.761Z|00117|coverage|INFO|cmap_shrink
0.0/sec     0.850/sec        0.0142/sec   total: 54
2018-08-24T21:27:39.761Z|00118|coverage|INFO|dpif_port_add
0.0/sec     0.017/sec        0.0003/sec   total: 2
2018-08-24T21:27:39.761Z|00119|coverage|INFO|dpif_flow_flush
0.0/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:39.761Z|00120|coverage|INFO|dpif_flow_get
0.0/sec     0.350/sec        0.0058/sec   total: 21
2018-08-24T21:27:39.761Z|00121|coverage|INFO|dpif_flow_put
0.0/sec     0.367/sec        0.0061/sec   total: 22
2018-08-24T21:27:39.761Z|00122|coverage|INFO|dpif_flow_del
0.0/sec     0.350/sec        0.0058/sec   total: 22
2018-08-24T21:27:39.761Z|00123|coverage|INFO|dpif_execute
 0.0/sec     0.067/sec        0.0011/sec   total: 4
2018-08-24T21:27:39.761Z|00124|coverage|INFO|flow_extract
 0.0/sec     0.050/sec        0.0008/sec   total: 3
2018-08-24T21:27:39.761Z|00125|coverage|INFO|miniflow_malloc
0.0/sec     1.050/sec        0.0175/sec   total: 63
2018-08-24T21:27:39.761Z|00126|coverage|INFO|hmap_pathological
0.0/sec     0.267/sec        0.0044/sec   total: 16
2018-08-24T21:27:39.762Z|00127|coverage|INFO|hmap_expand
6.8/sec    12.967/sec        0.2161/sec   total: 846
2018-08-24T21:27:39.762Z|00128|coverage|INFO|hmap_shrink
0.0/sec     0.000/sec        0.0000/sec   total: 1
2018-08-24T21:27:39.762Z|00129|coverage|INFO|mac_learning_learned
 0.0/sec     0.017/sec        0.0003/sec   total: 1
2018-08-24T21:27:39.762Z|00130|coverage|INFO|netdev_received
0.0/sec     0.100/sec        0.0017/sec   total: 8
2018-08-24T21:27:39.762Z|00131|coverage|INFO|netdev_get_stats
 0.2/sec     0.050/sec        0.0008/sec   total: 4
2018-08-24T21:27:39.762Z|00132|coverage|INFO|txn_unchanged
0.0/sec     0.100/sec        0.0017/sec   total: 6
2018-08-24T21:27:39.762Z|00133|coverage|INFO|txn_incomplete
 0.2/sec     0.133/sec        0.0022/sec   total: 8
2018-08-24T21:27:39.762Z|00134|coverage|INFO|txn_success
0.2/sec     0.083/sec        0.0014/sec   total: 5
2018-08-24T21:27:39.762Z|00135|coverage|INFO|poll_create_node
28.8/sec    24.750/sec        0.4125/sec   total: 30710
2018-08-24T21:27:39.762Z|00136|coverage|INFO|poll_zero_timeout
0.0/sec     0.083/sec        0.0014/sec   total: 6
2018-08-24T21:27:39.762Z|00137|coverage|INFO|rconn_queued
 0.0/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:39.762Z|00138|coverage|INFO|rconn_sent
 0.0/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:39.762Z|00139|coverage|INFO|seq_change
 1038.4/sec   204.633/sec        3.4106/sec   total: 45338
2018-08-24T21:27:39.762Z|00140|coverage|INFO|pstream_open
 0.0/sec     0.050/sec        0.0008/sec   total: 3
2018-08-24T21:27:39.762Z|00141|coverage|INFO|stream_open
0.0/sec     0.017/sec        0.0003/sec   total: 1
2018-08-24T21:27:39.762Z|00142|coverage|INFO|util_xalloc
131.2/sec   255.867/sec        4.2644/sec   total: 74499
2018-08-24T21:27:39.762Z|00143|coverage|INFO|vconn_received
 0.0/sec     0.083/sec        0.0014/sec   total: 5
2018-08-24T21:27:39.762Z|00144|coverage|INFO|vconn_sent
 0.0/sec     0.067/sec        0.0011/sec   total: 4
2018-08-24T21:27:39.762Z|00145|coverage|INFO|netdev_set_policing
0.0/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:39.762Z|00146|coverage|INFO|netdev_get_ifindex
 0.0/sec     0.017/sec        0.0003/sec   total: 1
2018-08-24T21:27:39.762Z|00147|coverage|INFO|netdev_get_hwaddr
0.0/sec     0.200/sec        0.0033/sec   total: 12
2018-08-24T21:27:39.763Z|00148|coverage|INFO|netdev_set_hwaddr
0.0/sec     0.017/sec        0.0003/sec   total: 2
2018-08-24T21:27:39.763Z|00149|coverage|INFO|netdev_get_ethtool
 0.0/sec     0.050/sec        0.0008/sec   total: 3
2018-08-24T21:27:39.763Z|00150|coverage|INFO|netlink_received
 0.4/sec     0.800/sec        0.0133/sec   total: 48
2018-08-24T21:27:39.763Z|00151|coverage|INFO|netlink_recv_jumbo
 0.2/sec     0.050/sec        0.0008/sec   total: 3
2018-08-24T21:27:39.763Z|00152|coverage|INFO|netlink_sent
 0.4/sec     0.350/sec        0.0058/sec   total: 21
2018-08-24T21:27:39.763Z|00153|coverage|INFO|nln_changed
0.0/sec     0.167/sec        0.0028/sec   total: 10
2018-08-24T21:27:39.763Z|00154|coverage|INFO|59 events never hit
2018-08-24T21:27:39.763Z|00155|poll_loop|INFO|wakeup due to [POLLIN] on fd
54 (FIFO pipe:[183625]) at lib/ovs-rcu.c:229 (57% CPU usage)
2018-08-24T21:27:41.263Z|00002|ovs_rcu(urcu2)|WARN|blocked 1000 ms waiting
for main to quiesce
2018-08-24T21:27:42.263Z|00003|ovs_rcu(urcu2)|WARN|blocked 2000 ms waiting
for main to quiesce
2018-08-24T21:27:43.158Z|00156|timeval|WARN|Unreasonably long 3394ms poll
interval (2231ms user, 76ms system)
2018-08-24T21:27:43.158Z|00157|timeval|WARN|faults: 1 minor, 0 major
2018-08-24T21:27:43.158Z|00158|timeval|WARN|context switches: 1 voluntary,
18404 involuntary
2018-08-24T21:27:43.158Z|00159|coverage|INFO|Event coverage, avg rate over
last: 5 seconds, last minute, last hour,  hash=30651da8:
2018-08-24T21:27:43.158Z|00160|coverage|INFO|bridge_reconfigure
 0.2/sec     0.083/sec        0.0014/sec   total: 5
2018-08-24T21:27:43.158Z|00161|coverage|INFO|ofproto_flush
0.0/sec     0.017/sec        0.0003/sec   total: 1
2018-08-24T21:27:43.158Z|00162|coverage|INFO|ofproto_recv_openflow
0.0/sec     0.050/sec        0.0008/sec   total: 3
2018-08-24T21:27:43.158Z|00163|coverage|INFO|ofproto_update_port
0.2/sec     0.067/sec        0.0011/sec   total: 4
2018-08-24T21:27:43.158Z|00164|coverage|INFO|rev_reconfigure
0.2/sec     0.083/sec        0.0014/sec   total: 5
2018-08-24T21:27:43.158Z|00165|coverage|INFO|rev_flow_table
 0.0/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:43.158Z|00166|coverage|INFO|xlate_actions
0.4/sec     0.200/sec        0.0033/sec   total: 12
2018-08-24T21:27:43.158Z|00167|coverage|INFO|cmap_expand
0.0/sec     1.217/sec        0.0203/sec   total: 87
2018-08-24T21:27:43.158Z|00168|coverage|INFO|cmap_shrink
0.8/sec     0.917/sec        0.0153/sec   total: 69
2018-08-24T21:27:43.158Z|00169|coverage|INFO|dpif_port_add
0.2/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:43.158Z|00170|coverage|INFO|dpif_flow_flush
0.0/sec     0.033/sec        0.0006/sec   total: 2
2018-08-24T21:27:43.158Z|00171|coverage|INFO|dpif_flow_get
0.0/sec     0.350/sec        0.0058/sec   total: 21
2018-08-24T21:27:43.158Z|00172|coverage|INFO|dpif_flow_put
0.0/sec     0.367/sec        0.0061/sec   total: 22
2018-08-24T21:27:43.158Z|00173|coverage|INFO|dpif_flow_del
0.4/sec     0.383/sec        0.0064/sec   total: 23
2018-08-24T21:27:43.158Z|00174|coverage|INFO|dpif_execute
 0.0/sec     0.067/sec        0.0011/sec   total: 4
2018-08-24T21:27:43.158Z|00175|coverage|INFO|flow_extract
 0.0/sec     0.050/sec        0.0008/sec   total: 3
2018-08-24T21:27:43.158Z|00176|coverage|INFO|miniflow_malloc
0.0/sec     1.050/sec        0.0175/sec   total: 85
2018-08-24T21:27:43.158Z|00177|coverage|INFO|hmap_pathological
0.0/sec     0.267/sec        0.0044/sec   total: 16
2018-08-24T21:27:43.158Z|00178|coverage|INFO|hmap_expand
 13.6/sec    14.100/sec        0.2350/sec   total: 884
2018-08-24T21:27:43.158Z|00179|coverage|INFO|hmap_shrink
0.2/sec     0.017/sec        0.0003/sec   total: 1
2018-08-24T21:27:43.158Z|00180|coverage|INFO|mac_learning_learned
 0.0/sec     0.017/sec        0.0003/sec   total: 1
2018-08-24T21:27:43.158Z|00181|coverage|INFO|netdev_received
0.4/sec     0.133/sec        0.0022/sec   total: 8
2018-08-24T21:27:43.158Z|00182|coverage|INFO|netdev_get_stats
 0.2/sec     0.067/sec        0.0011/sec   total: 6
2018-08-24T21:27:43.158Z|00183|coverage|INFO|txn_unchanged
0.0/sec     0.100/sec        0.0017/sec   total: 6
2018-08-24T21:27:43.158Z|00184|coverage|INFO|txn_incomplete
 0.0/sec     0.133/sec        0.0022/sec   total: 11
2018-08-24T21:27:43.158Z|00185|coverage|INFO|txn_success
0.0/sec     0.083/sec        0.0014/sec   total: 5
2018-08-24T21:27:43.158Z|00186|coverage|INFO|poll_create_node
 12398.0/sec  1057.917/sec       17.6319/sec   total: 79467
2018-08-24T21:27:43.158Z|00187|coverage|INFO|poll_zero_timeout
0.4/sec     0.117/sec        0.0019/sec   total: 8



[root at beast bin]# ovs-vsctl show
3465b41d-2f42-4dd4-8f25-90bdd69384ae
    Bridge "br0"
        Port "data_10g-3"
            Interface "data_10g-3"
                type: dpdk
                options: {dpdk-devargs="0000:0b:00.1", n_rxq="2"}
        Port "data_10g-2"
            Interface "data_10g-2"
                type: dpdk
                options: {dpdk-devargs="0000:0b:00.0", n_rxq="2"}
        Port "br0"
            Interface "br0"
                type: internal
[root at beast bin]# ovs-ofctl dump-ports br0
OFPST_PORT reply (xid=0x2): 3 ports
  port LOCAL: rx pkts=184, bytes=16044, drop=0, errs=0, frame=0, over=0,
crc=0
           tx pkts=0, bytes=0, drop=0, errs=0, coll=0
  port  "data_10g-2": rx pkts=0, bytes=0, drop=0, errs=0, frame=?, over=?,
crc=?
           tx pkts=0, bytes=0, drop=0, errs=0, coll=?
  port  "data_10g-3": rx pkts=0, bytes=0, drop=0, errs=0, frame=?, over=?,
crc=?
           tx pkts=0, bytes=0, drop=0, errs=0, coll=?
[root at beast bin]# ovs-ofctl show br0
OFPT_FEATURES_REPLY (xid=0x2): dpid:00003c2c99f880ea
n_tables:254, n_buffers:0
capabilities: FLOW_STATS TABLE_STATS PORT_STATS QUEUE_STATS ARP_MATCH_IP
actions: output enqueue set_vlan_vid set_vlan_pcp strip_vlan mod_dl_src
mod_dl_dst mod_nw_src mod_nw_dst mod_nw_tos mod_tp_src mod_tp_dst
 1(data_10g-2): addr:3c:2c:99:f8:80:ea
     config:     0
     state:      LINK_DOWN
     current:    10MB-FD 100MB-FD 10GB-FD FIBER AUTO_NEG AUTO_PAUSE
     speed: 10000 Mbps now, 0 Mbps max
 2(data_10g-3): addr:3c:2c:99:f8:80:eb
     config:     0
     state:      LINK_DOWN
     current:    10MB-FD 100MB-FD 10GB-FD FIBER AUTO_NEG AUTO_PAUSE
     speed: 10000 Mbps now, 0 Mbps max
 LOCAL(br0): addr:3c:2c:99:f8:80:ea
     config:     0
     state:      0
     current:    10MB-FD COPPER
     speed: 10 Mbps now, 0 Mbps max
OFPT_GET_CONFIG_REPLY (xid=0x4): frags=normal miss_send_len=0
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mail.openvswitch.org/pipermail/ovs-discuss/attachments/20180824/61abba5e/attachment-0001.html>


More information about the discuss mailing list