On Thu, Jun 25, 2015 at 11:22:00AM -0700, Jesse Gross wrote:
> Currently the userspace datapath only supports Geneve in a
> basic mode - without options - since the rest of userspace
> previously didn't support options either. This enables the
> userspace datapath to send and receive options as well.
>
> The receive path for extracting the tunnel options isn't entirely
> optimal because it does a lookup on the options on a per-packet
> basis, rather than per-flow like the kernel does. This is not
> as straightforward to do in the userspace datapath since there
> is no translation step between packet formats used in packet vs.
> flow lookup. This can be optimized in the future and in the
> meantime option support is still useful for testing and simulation.
>
> Signed-off-by: Jesse Gross <je...@nicira.com>
That was fast!
This gives me a repeatable test failure (on i386), log attached.
"git am" says:
Applying: tunneling: Userspace datapath support for Geneve options.
/home/blp/nicira/ovs/.git/rebase-apply/patch:89: trailing whitespace.
gnh->critical = crit_opt ? 1 : 0;
/home/blp/nicira/ovs/.git/rebase-apply/patch:127: trailing whitespace.
warning: 2 lines add whitespace errors.
In ovs_parse_tnl_push(), I would consider changing
if (!ovs_scan_len(s, &n, "vni=0x%"SCNx32, &vni)) {
to
if (!ovs_scan_len(s, &n, "vni=%"SCNi32, &vni)) {
to allow a handwritten vni to be expressed in decimal (this is not
new code with this patch).
Also in ovs_parse_tnl_push(), it looks like the code now expects
'geneve()' to always end with a doubled ), but I think that it should
only do that if there are options.
The {} syntax looks a little odd nested inside so many (), did you
consider using something like
geneve(crit,vni=0x1c7,option(class=0xffff,type=0x80,len=4,0xa))
and then just allowing multiple "option"s directly inside geneve()?
# -*- compilation -*-
637. tunnel-push-pop.at:3: testing tunnel_push_pop - action ...
../../tests/tunnel-push-pop.at:5: ovsdb-tool create conf.db
$abs_top_srcdir/vswitchd/vswitch.ovsschema
../../tests/tunnel-push-pop.at:5: ovsdb-server --detach --no-chdir --pidfile
--log-file --remote=punix:$OVS_RUNDIR/db.sock
stderr:
2015-06-26T16:01:00Z|00001|vlog|INFO|opened log file
/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/ovsdb-server.log
cat: cleanup: No such file or directory
../../tests/tunnel-push-pop.at:5: sed < stderr '
/vlog|INFO|opened log file/d
/ovsdb_server|INFO|ovsdb-server (Open vSwitch)/d'
../../tests/tunnel-push-pop.at:5: ovs-vsctl --no-wait init
../../tests/tunnel-push-pop.at:5: ovs-vswitchd --enable-dummy --disable-system
--detach --no-chdir --pidfile --log-file -vvconn -vofproto_dpif
stderr:
2015-06-26T16:01:00Z|00001|vlog|INFO|opened log file
/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/ovs-vswitchd.log
2015-06-26T16:01:00Z|00002|ovs_numa|INFO|Discovered 8 CPU cores on NUMA node 0
2015-06-26T16:01:00Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 8 CPU cores
2015-06-26T16:01:00Z|00004|reconnect|INFO|unix:/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/db.sock:
connecting...
2015-06-26T16:01:00Z|00005|reconnect|INFO|unix:/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/db.sock:
connected
../../tests/tunnel-push-pop.at:5: sed < stderr '
/ovs_numa|INFO|Discovered /d
/vlog|INFO|opened log file/d
/vswitchd|INFO|ovs-vswitchd (Open vSwitch)/d
/reconnect|INFO|/d
/ofproto|INFO|using datapath ID/d
/ofproto|INFO|datapath ID changed to fedcba9876543210/d'
../../tests/tunnel-push-pop.at:5: ovs-vsctl -- add-br br0 -- set bridge br0
datapath-type=dummy other-config:datapath-id=fedcba9876543210
other-config:hwaddr=aa:55:aa:55:00:00
protocols=[OpenFlow10,OpenFlow11,OpenFlow12,OpenFlow13,OpenFlow14,OpenFlow15]
fail-mode=secure -- add-port br0 p0 -- set Interface p0 type=dummy
ofport_request=1
../../tests/tunnel-push-pop.at:6: ovs-vsctl add-br int-br -- set bridge int-br
datapath_type=dummy
../../tests/tunnel-push-pop.at:7: ovs-vsctl add-port int-br t2 -- set Interface
t2 type=vxlan \
options:remote_ip=1.1.2.92 options:key=123
ofport_request=2\
-- add-port int-br t1 -- set Interface t1 type=gre \
options:remote_ip=1.1.2.92 options:key=456
ofport_request=3\
-- add-port int-br t3 -- set Interface t3 type=vxlan \
options:remote_ip=1.1.2.93 options:out_key=flow
options:csum=true ofport_request=4\
-- add-port int-br t4 -- set Interface t4 type=geneve \
options:remote_ip=flow options:key=123 ofport_request=5\
../../tests/tunnel-push-pop.at:17: ovs-appctl dpif/show
../../tests/tunnel-push-pop.at:30: ovs-appctl ovs/route/add 1.1.2.92/24 br0
../../tests/tunnel-push-pop.at:32: ovs-appctl netdev-dummy/ip4addr br0
1.1.2.88/24
../../tests/tunnel-push-pop.at:35: ovs-ofctl add-flow br0 action=normal
../../tests/tunnel-push-pop.at:38: ovs-appctl netdev-dummy/receive br0
'recirc_id(0),in_port(100),eth(src=f8:bc:12:44:34:b6,dst=ff:ff:ff:ff:ff:ff),eth_type(0x0806),arp(sip=1.1.2.92,tip=1.1.2.88,op=1,sha=f8:bc:12:44:34:b6,tha=00:00:00:00:00:00)'
../../tests/tunnel-push-pop.at:39: ovs-appctl netdev-dummy/receive br0
'recirc_id(0),in_port(100),eth(src=f8:bc:12:44:34:b7,dst=ff:ff:ff:ff:ff:ff),eth_type(0x0806),arp(sip=1.1.2.93,tip=1.1.2.88,op=1,sha=f8:bc:12:44:34:b7,tha=00:00:00:00:00:00)'
../../tests/tunnel-push-pop.at:41: ovs-appctl tnl/arp/show
../../tests/tunnel-push-pop.at:48: ovs-appctl tnl/ports/show |sort
../../tests/tunnel-push-pop.at:56: ovs-appctl ofproto/trace ovs-dummy
'in_port(1),eth(src=f8:bc:12:44:34:b6,dst=f8:bc:12:46:58:e0),eth_type(0x0800),ipv4(src=1.1.2.92,dst=1.1.2.88,proto=17,tos=0,ttl=64,frag=no),udp(src=51283,dst=4789)'
stdout:
Bridge: br0
Flow:
udp,in_port=1,vlan_tci=0x0000,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,nw_src=1.1.2.92,nw_dst=1.1.2.88,nw_tos=0,nw_ecn=0,nw_ttl=64,tp_src=51283,tp_dst=4789
Rule: table=0 cookie=0
OpenFlow actions=NORMAL
no learned MAC for destination, flooding
Final flow:
udp,in_port=1,vlan_tci=0x0000,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,nw_src=1.1.2.92,nw_dst=1.1.2.88,nw_tos=0,nw_ecn=0,nw_ttl=64,tp_src=51283,tp_dst=4789
Megaflow:
recirc_id=0,udp,in_port=1,vlan_tci=0x0000/0x1fff,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,tp_dst=4789
Datapath actions: tnl_pop(4789)
../../tests/tunnel-push-pop.at:57: tail -1 stdout
../../tests/tunnel-push-pop.at:62: ovs-appctl ofproto/trace ovs-dummy
'in_port(1),eth(src=f8:bc:12:44:34:b6,dst=f8:bc:12:46:58:e0),eth_type(0x0800),ipv4(src=1.1.2.92,dst=1.1.2.88,proto=47,tos=0,ttl=64,frag=no)'
stdout:
Bridge: br0
Flow:
ip,in_port=1,vlan_tci=0x0000,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,nw_src=1.1.2.92,nw_dst=1.1.2.88,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Rule: table=0 cookie=0
OpenFlow actions=NORMAL
no learned MAC for destination, flooding
Final flow:
ip,in_port=1,vlan_tci=0x0000,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,nw_src=1.1.2.92,nw_dst=1.1.2.88,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Megaflow:
recirc_id=0,ip,in_port=1,vlan_tci=0x0000/0x1fff,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,nw_proto=47,tp_dst=0
Datapath actions: tnl_pop(3)
../../tests/tunnel-push-pop.at:63: tail -1 stdout
../../tests/tunnel-push-pop.at:68: ovs-appctl ofproto/trace ovs-dummy
'in_port(1),eth(src=f8:bc:12:44:34:b6,dst=f8:bc:12:46:58:e0),eth_type(0x0800),ipv4(src=1.1.2.92,dst=1.1.2.88,proto=17,tos=0,ttl=64,frag=no),udp(src=51283,dst=6081)'
stdout:
Bridge: br0
Flow:
udp,in_port=1,vlan_tci=0x0000,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,nw_src=1.1.2.92,nw_dst=1.1.2.88,nw_tos=0,nw_ecn=0,nw_ttl=64,tp_src=51283,tp_dst=6081
Rule: table=0 cookie=0
OpenFlow actions=NORMAL
no learned MAC for destination, flooding
Final flow:
udp,in_port=1,vlan_tci=0x0000,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,nw_src=1.1.2.92,nw_dst=1.1.2.88,nw_tos=0,nw_ecn=0,nw_ttl=64,tp_src=51283,tp_dst=6081
Megaflow:
recirc_id=0,udp,in_port=1,vlan_tci=0x0000/0x1fff,dl_src=f8:bc:12:44:34:b6,dl_dst=f8:bc:12:46:58:e0,tp_dst=6081
Datapath actions: tnl_pop(6081)
../../tests/tunnel-push-pop.at:69: tail -1 stdout
../../tests/tunnel-push-pop.at:74: ovs-ofctl add-flow int-br action=2
../../tests/tunnel-push-pop.at:75: ovs-appctl ofproto/trace ovs-dummy
'in_port(2),eth_type(0x0800),ipv4(src=1.1.3.88,dst=1.1.3.112,proto=47,tos=0,ttl=64,frag=no)'
stdout:
Bridge: int-br
Flow:
ip,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Rule: table=0 cookie=0
OpenFlow actions=output:2
output to native tunnel
tunneling to 1.1.2.92 via br0
tunneling from aa:55:aa:55:00:00 1.1.2.88 to f8:bc:12:44:34:b6 1.1.2.92
Final flow:
ip,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Megaflow: recirc_id=0,ip,in_port=LOCAL,nw_ecn=0,nw_frag=no
Datapath actions:
tnl_push(tnl_port(4789),header(size=50,type=4,eth(dst=f8:bc:12:44:34:b6,src=aa:55:aa:55:00:00,dl_type=0x0800),ipv4(src=1.1.2.88,dst=1.1.2.92,proto=17,tos=0,ttl=64,frag=0x40),udp(src=0,dst=4789,csum=0x0),vxlan(flags=0x8000000,vni=0x7b)),out_port(100))
../../tests/tunnel-push-pop.at:76: tail -1 stdout
../../tests/tunnel-push-pop.at:81: ovs-ofctl add-flow int-br
"actions=set_tunnel:124,4"
../../tests/tunnel-push-pop.at:82: ovs-appctl ofproto/trace ovs-dummy
'in_port(2),eth_type(0x0800),ipv4(src=1.1.3.88,dst=1.1.3.112,proto=47,tos=0,ttl=64,frag=no)'
stdout:
Bridge: int-br
Flow:
ip,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Rule: table=0 cookie=0
OpenFlow actions=set_tunnel:0x7c,output:4
output to native tunnel
tunneling to 1.1.2.93 via br0
tunneling from aa:55:aa:55:00:00 1.1.2.88 to f8:bc:12:44:34:b7 1.1.2.93
Final flow:
ip,tun_id=0x7c,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Megaflow: recirc_id=0,ip,in_port=LOCAL,nw_ecn=0,nw_frag=no
Datapath actions:
tnl_push(tnl_port(4789),header(size=50,type=4,eth(dst=f8:bc:12:44:34:b7,src=aa:55:aa:55:00:00,dl_type=0x0800),ipv4(src=1.1.2.88,dst=1.1.2.93,proto=17,tos=0,ttl=64,frag=0x40),udp(src=0,dst=4789,csum=0xffff),vxlan(flags=0x8000000,vni=0x7c)),out_port(100))
../../tests/tunnel-push-pop.at:83: tail -1 stdout
../../tests/tunnel-push-pop.at:88: ovs-ofctl add-flow int-br action=3
../../tests/tunnel-push-pop.at:89: ovs-appctl ofproto/trace ovs-dummy
'in_port(2),eth_type(0x0800),ipv4(src=1.1.3.88,dst=1.1.3.112,proto=47,tos=0,ttl=64,frag=no)'
stdout:
Bridge: int-br
Flow:
ip,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Rule: table=0 cookie=0
OpenFlow actions=output:3
output to native tunnel
tunneling to 1.1.2.92 via br0
tunneling from aa:55:aa:55:00:00 1.1.2.88 to f8:bc:12:44:34:b6 1.1.2.92
Final flow:
ip,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Megaflow: recirc_id=0,ip,in_port=LOCAL,nw_ecn=0,nw_frag=no
Datapath actions:
tnl_push(tnl_port(3),header(size=42,type=3,eth(dst=f8:bc:12:44:34:b6,src=aa:55:aa:55:00:00,dl_type=0x0800),ipv4(src=1.1.2.88,dst=1.1.2.92,proto=47,tos=0,ttl=64,frag=0x40),gre((flags=0x2000,proto=0x6558),key=0x1c8)),out_port(100))
../../tests/tunnel-push-pop.at:90: tail -1 stdout
../../tests/tunnel-push-pop.at:95: ovs-ofctl add-flow int-br
"actions=set_field:1.1.2.92->tun_dst,5"
../../tests/tunnel-push-pop.at:96: ovs-appctl ofproto/trace ovs-dummy
'in_port(2),eth_type(0x0800),ipv4(src=1.1.3.88,dst=1.1.3.112,proto=47,tos=0,ttl=64,frag=no)'
stdout:
Bridge: int-br
Flow:
ip,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Rule: table=0 cookie=0
OpenFlow actions=load:0x101025c->NXM_NX_TUN_IPV4_DST[],output:5
output to native tunnel
tunneling to 1.1.2.92 via br0
tunneling from aa:55:aa:55:00:00 1.1.2.88 to f8:bc:12:44:34:b6 1.1.2.92
Final flow:
ip,tun_src=0.0.0.0,tun_dst=1.1.2.92,tun_gbp_id=0,tun_gbp_flags=0,tun_tos=0,tun_ttl=0,,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Megaflow: recirc_id=0,ip,tun_dst=0.0.0.0,in_port=LOCAL,nw_ecn=0,nw_frag=no
Datapath actions:
tnl_push(tnl_port(6081),header(size=50,type=5,eth(dst=f8:bc:12:44:34:b6,src=aa:55:aa:55:00:00,dl_type=0x0800),ipv4(src=1.1.2.88,dst=1.1.2.92,proto=17,tos=0,ttl=64,frag=0x40),udp(src=0,dst=6081,csum=0x0),geneve(vni=0x7b)),out_port(100))
../../tests/tunnel-push-pop.at:97: tail -1 stdout
../../tests/tunnel-push-pop.at:102: ovs-ofctl add-geneve-map int-br
"{class=0xffff,type=0x80,len=4}->tun_metadata0"
../../tests/tunnel-push-pop.at:103: ovs-ofctl add-flow int-br
"actions=set_field:0xa->tun_metadata0,5"
../../tests/tunnel-push-pop.at:104: ovs-appctl ofproto/trace ovs-dummy
'in_port(2),eth_type(0x0800),ipv4(src=1.1.3.88,dst=1.1.3.112,proto=47,tos=0,ttl=64,frag=no)'
stdout:
Bridge: int-br
Flow:
ip,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Rule: table=0 cookie=0
OpenFlow
actions=load:0xa->NXM_NX_TUN_METADATA0[0..63],load:0->NXM_NX_TUN_METADATA0[64..127],load:0->NXM_NX_TUN_METADATA0[128..191],load:0->NXM_NX_TUN_METADATA0[192..255],load:0->NXM_NX_TUN_METADATA0[256..319],load:0->NXM_NX_TUN_METADATA0[320..383],load:0->NXM_NX_TUN_METADATA0[384..447],load:0->NXM_NX_TUN_METADATA0[448..511],load:0->NXM_NX_TUN_METADATA0[512..575],load:0->NXM_NX_TUN_METADATA0[576..639],load:0->NXM_NX_TUN_METADATA0[640..703],load:0->NXM_NX_TUN_METADATA0[704..767],load:0->NXM_NX_TUN_METADATA0[768..831],load:0->NXM_NX_TUN_METADATA0[832..895],load:0->NXM_NX_TUN_METADATA0[896..959],load:0->NXM_NX_TUN_METADATA0[960..991],output:5
Not tunneling to our own address
Final flow:
ip,tun_id=0x7b,in_port=LOCAL,vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,nw_src=1.1.3.88,nw_dst=1.1.3.112,nw_proto=47,nw_tos=0,nw_ecn=0,nw_ttl=64
Megaflow: recirc_id=0,ip,tun_metadata0=0,in_port=LOCAL,nw_ecn=0,nw_frag=no
Datapath actions: drop
../../tests/tunnel-push-pop.at:105: tail -1 stdout
--- - 2015-06-26 09:01:00.228248669 -0700
+++ /home/blp/nicira/ovs/_build/tests/testsuite.dir/at-groups/637/stdout
2015-06-26 09:01:00.222513336 -0700
@@ -1,2 +1,2 @@
-Datapath actions:
tnl_push(tnl_port(6081),header(size=58,type=5,eth(dst=f8:bc:12:44:34:b6,src=aa:55:aa:55:00:00,dl_type=0x0800),ipv4(src=1.1.2.88,dst=1.1.2.92,proto=17,tos=0,ttl=64,frag=0x40),udp(src=0,dst=6081,csum=0x0),geneve(crit,vni=0x7b,options({class=0xffff,type=0x80,len=4,0xa}))),out_port(100))
+Datapath actions: drop
ovsdb-server.log:
> 2015-06-26T16:01:00.140Z|00001|vlog|INFO|opened log file
> /home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/ovsdb-server.log
> 2015-06-26T16:01:00.142Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch)
> 2.4.90
ovs-vswitchd.log:
> 2015-06-26T16:01:00.150Z|00001|vlog|INFO|opened log file
> /home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/ovs-vswitchd.log
> 2015-06-26T16:01:00.150Z|00002|ovs_numa|INFO|Discovered 8 CPU cores on NUMA
> node 0
> 2015-06-26T16:01:00.150Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 8
> CPU cores
> 2015-06-26T16:01:00.150Z|00004|reconnect|INFO|unix:/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/db.sock:
> connecting...
> 2015-06-26T16:01:00.150Z|00005|reconnect|INFO|unix:/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/db.sock:
> connected
> 2015-06-26T16:01:00.152Z|00006|bridge|INFO|ovs-vswitchd (Open vSwitch) 2.4.90
> 2015-06-26T16:01:00.161Z|00007|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath
> supports recirculation
> 2015-06-26T16:01:00.161Z|00008|ofproto_dpif|INFO|dummy@ovs-dummy: MPLS label
> stack length probed as 3
> 2015-06-26T16:01:00.161Z|00009|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath
> supports unique flow ids
> 2015-06-26T16:01:00.161Z|00010|bridge|INFO|bridge br0: added interface p0 on
> port 1
> 2015-06-26T16:01:00.161Z|00011|bridge|INFO|bridge br0: added interface br0 on
> port 65534
> 2015-06-26T16:01:00.161Z|00012|bridge|INFO|bridge br0: using datapath ID
> fedcba9876543210
> 2015-06-26T16:01:00.161Z|00013|connmgr|INFO|br0: added service controller
> "punix:/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/br0.mgmt"
> 2015-06-26T16:01:00.168Z|00014|bridge|INFO|bridge int-br: added interface
> int-br on port 65534
> 2015-06-26T16:01:00.168Z|00015|bridge|INFO|bridge int-br: using datapath ID
> 00004e78b0289045
> 2015-06-26T16:01:00.168Z|00016|connmgr|INFO|int-br: added service controller
> "punix:/home/blp/nicira/ovs/_build/tests/testsuite.dir/0637/int-br.mgmt"
> 2015-06-26T16:01:00.174Z|00017|bridge|INFO|bridge int-br: added interface t3
> on port 4
> 2015-06-26T16:01:00.174Z|00018|bridge|INFO|bridge int-br: added interface t2
> on port 2
> 2015-06-26T16:01:00.174Z|00019|bridge|INFO|bridge int-br: added interface t4
> on port 5
> 2015-06-26T16:01:00.174Z|00020|bridge|INFO|bridge int-br: added interface t1
> on port 3
> 2015-06-26T16:01:00.175Z|00021|ofproto_dpif|DBG|need revalidate in
> ofproto_wait_cb()
> 2015-06-26T16:01:00.175Z|00022|ofproto_dpif|DBG|need revalidate in
> ofproto_wait_cb()
> 2015-06-26T16:01:00.182Z|00023|vconn|DBG|unix: sent (Success): OFPT_HELLO
> (OF1.5) (xid=0x1):
> version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06
> 2015-06-26T16:01:00.182Z|00024|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2015-06-26T16:01:00.182Z|00025|vconn|DBG|unix: negotiated OpenFlow version
> 0x01 (we support version 0x06 and earlier, peer supports version 0x01)
> 2015-06-26T16:01:00.182Z|00026|vconn|DBG|unix: received: OFPT_FLOW_MOD
> (xid=0x2): ADD actions=NORMAL
> 2015-06-26T16:01:00.182Z|00027|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x3):
> 2015-06-26T16:01:00.182Z|00028|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x3):
> 2015-06-26T16:01:00.182Z|00029|connmgr|INFO|br0<->unix: 1 flow_mods in the
> last 0 s (1 adds)
> 2015-06-26T16:01:00.182Z|00030|ofproto_dpif|DBG|need revalidate in
> ofproto_wait_cb()
> 2015-06-26T16:01:00.182Z|00031|ofproto_dpif|DBG|need revalidate in
> ofproto_wait_cb()
> 2015-06-26T16:01:00.184Z|00032|ofproto_dpif|DBG|need revalidate in
> ofproto_wait_cb()
> 2015-06-26T16:01:00.202Z|00033|vconn|DBG|unix: sent (Success): OFPT_HELLO
> (OF1.3) (xid=0x2):
> version bitmap: 0x01, 0x02, 0x03, 0x04
> 2015-06-26T16:01:00.202Z|00034|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2015-06-26T16:01:00.202Z|00035|vconn|DBG|unix: negotiated OpenFlow version
> 0x01 (we support version 0x04 and earlier, peer supports version 0x01)
> 2015-06-26T16:01:00.202Z|00036|vconn|DBG|unix: received: OFPT_FLOW_MOD
> (xid=0x2): ADD actions=output:2
> 2015-06-26T16:01:00.202Z|00037|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x3):
> 2015-06-26T16:01:00.202Z|00038|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x3):
> 2015-06-26T16:01:00.202Z|00039|connmgr|INFO|int-br<->unix: 1 flow_mods in the
> last 0 s (1 adds)
> 2015-06-26T16:01:00.207Z|00040|vconn|DBG|unix: sent (Success): OFPT_HELLO
> (OF1.3) (xid=0x3):
> version bitmap: 0x01, 0x02, 0x03, 0x04
> 2015-06-26T16:01:00.207Z|00041|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2015-06-26T16:01:00.207Z|00042|vconn|DBG|unix: negotiated OpenFlow version
> 0x01 (we support version 0x04 and earlier, peer supports version 0x01)
> 2015-06-26T16:01:00.207Z|00043|vconn|DBG|unix: received: OFPT_FLOW_MOD
> (xid=0x2): ADD actions=set_tunnel:0x7c,output:4
> 2015-06-26T16:01:00.207Z|00044|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x3):
> 2015-06-26T16:01:00.207Z|00045|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x3):
> 2015-06-26T16:01:00.207Z|00046|connmgr|INFO|int-br<->unix: 1 flow_mods in the
> last 0 s (1 adds)
> 2015-06-26T16:01:00.212Z|00047|vconn|DBG|unix: sent (Success): OFPT_HELLO
> (OF1.3) (xid=0x4):
> version bitmap: 0x01, 0x02, 0x03, 0x04
> 2015-06-26T16:01:00.212Z|00048|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2015-06-26T16:01:00.212Z|00049|vconn|DBG|unix: negotiated OpenFlow version
> 0x01 (we support version 0x04 and earlier, peer supports version 0x01)
> 2015-06-26T16:01:00.212Z|00050|vconn|DBG|unix: received: OFPT_FLOW_MOD
> (xid=0x2): ADD actions=output:3
> 2015-06-26T16:01:00.212Z|00051|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x3):
> 2015-06-26T16:01:00.212Z|00052|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x3):
> 2015-06-26T16:01:00.212Z|00053|connmgr|INFO|int-br<->unix: 1 flow_mods in the
> last 0 s (1 adds)
> 2015-06-26T16:01:00.217Z|00054|vconn|DBG|unix: sent (Success): OFPT_HELLO
> (OF1.3) (xid=0x5):
> version bitmap: 0x01, 0x02, 0x03, 0x04
> 2015-06-26T16:01:00.217Z|00055|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2015-06-26T16:01:00.217Z|00056|vconn|DBG|unix: negotiated OpenFlow version
> 0x01 (we support version 0x04 and earlier, peer supports version 0x01)
> 2015-06-26T16:01:00.217Z|00057|vconn|DBG|unix: received: NXT_SET_FLOW_FORMAT
> (xid=0x2): format=nxm
> 2015-06-26T16:01:00.217Z|00058|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x3):
> 2015-06-26T16:01:00.217Z|00059|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x3):
> 2015-06-26T16:01:00.217Z|00060|vconn|DBG|unix: received: NXT_FLOW_MOD
> (xid=0x4): ADD actions=load:0x101025c->NXM_NX_TUN_IPV4_DST[],output:5
> 2015-06-26T16:01:00.217Z|00061|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x5):
> 2015-06-26T16:01:00.217Z|00062|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x5):
> 2015-06-26T16:01:00.217Z|00063|connmgr|INFO|int-br<->unix: 1 flow_mods in the
> last 0 s (1 adds)
> 2015-06-26T16:01:00.222Z|00064|vconn|DBG|unix: sent (Success): OFPT_HELLO
> (OF1.3) (xid=0x6):
> version bitmap: 0x01, 0x02, 0x03, 0x04
> 2015-06-26T16:01:00.222Z|00065|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2015-06-26T16:01:00.222Z|00066|vconn|DBG|unix: negotiated OpenFlow version
> 0x01 (we support version 0x04 and earlier, peer supports version 0x01)
> 2015-06-26T16:01:00.222Z|00067|vconn|DBG|unix: received: NXT_SET_FLOW_FORMAT
> (xid=0x2): format=nxm
> 2015-06-26T16:01:00.222Z|00068|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x3):
> 2015-06-26T16:01:00.222Z|00069|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x3):
> 2015-06-26T16:01:00.222Z|00070|vconn|DBG|unix: received: NXT_GENEVE_TABLE_MOD
> (xid=0x4):
> ADD mapping table:
> class type length match field
> ----- ---- ------ -----------
> 0xffff 0x80 4 tun_metadata0
> 2015-06-26T16:01:00.222Z|00071|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x5):
> 2015-06-26T16:01:00.222Z|00072|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x5):
> 2015-06-26T16:01:00.223Z|00073|vconn|DBG|unix: sent (Success): OFPT_HELLO
> (OF1.3) (xid=0x7):
> version bitmap: 0x01, 0x02, 0x03, 0x04
> 2015-06-26T16:01:00.223Z|00074|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2015-06-26T16:01:00.223Z|00075|vconn|DBG|unix: negotiated OpenFlow version
> 0x01 (we support version 0x04 and earlier, peer supports version 0x01)
> 2015-06-26T16:01:00.223Z|00076|vconn|DBG|unix: received: NXT_SET_FLOW_FORMAT
> (xid=0x2): format=nxm
> 2015-06-26T16:01:00.223Z|00077|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x3):
> 2015-06-26T16:01:00.223Z|00078|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x3):
> 2015-06-26T16:01:00.224Z|00079|vconn|DBG|unix: received: NXT_FLOW_MOD
> (xid=0x4): ADD
> actions=load:0xa->NXM_NX_TUN_METADATA0[0..63],load:0->NXM_NX_TUN_METADATA0[64..127],load:0->NXM_NX_TUN_METADATA0[128..191],load:0->NXM_NX_TUN_METADATA0[192..255],load:0->NXM_NX_TUN_METADATA0[256..319],load:0->NXM_NX_TUN_METADATA0[320..383],load:0->NXM_NX_TUN_METADATA0[384..447],load:0->NXM_NX_TUN_METADATA0[448..511],load:0->NXM_NX_TUN_METADATA0[512..575],load:0->NXM_NX_TUN_METADATA0[576..639],load:0->NXM_NX_TUN_METADATA0[640..703],load:0->NXM_NX_TUN_METADATA0[704..767],load:0->NXM_NX_TUN_METADATA0[768..831],load:0->NXM_NX_TUN_METADATA0[832..895],load:0->NXM_NX_TUN_METADATA0[896..959],load:0->NXM_NX_TUN_METADATA0[960..991],output:5
> 2015-06-26T16:01:00.224Z|00080|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST
> (xid=0x5):
> 2015-06-26T16:01:00.224Z|00081|vconn|DBG|unix: sent (Success):
> OFPT_BARRIER_REPLY (xid=0x5):
> 2015-06-26T16:01:00.224Z|00082|connmgr|INFO|int-br<->unix: 1 flow_mods in the
> last 0 s (1 adds)
637. tunnel-push-pop.at:3: 637. tunnel_push_pop - action
(tunnel-push-pop.at:3): FAILED (tunnel-push-pop.at:105)
_______________________________________________
dev mailing list
dev@openvswitch.org
http://openvswitch.org/mailman/listinfo/dev
