Ubuntu
openvswitch package

unit test failures with master branch on i386

Bug #1609846 reported by James Page
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
openvswitch (Ubuntu)
Fix Released
Medium
Unassigned

Bug Description

PPA build for reference:

  https://launchpadlibrarian.net/276760442/buildlog_ubuntu-yakkety-i386.openvswitch_2.6.0~git20160804.0a0f39d-0ubuntu1~ubuntu16.10.1~ppa201608041413_BUILDING.txt.gz

Tests pass OK on amd64; there are actually 5 test failures on the parallel run - 3 of which pass on a recheck.

Actual test failures:

## ------------- ##
## Test results. ##
## ------------- ##

ERROR: All 5 tests were run,
2 failed unexpectedly.

## ------------------------ ##
## Summary of the failures. ##
## ------------------------ ##
Failed tests:
openvswitch 2.5.90 test suite test groups:

 NUM: FILE-NAME:LINE TEST-GROUP-NAME
      KEYWORDS

 1149: ofproto-dpif.at:8008 ofproto-dpif - in place modification (vlan)
 2214: ovn.at:1164 ovn -- vtep: 3 HVs, 1 VIFs/HV, 1 GW, 1 LS
      vtep

## ---------------------- ##
## Detailed failed tests. ##
## ---------------------- ##

# -*- compilation -*-
1149. ofproto-dpif.at:8008: testing ofproto-dpif - in place modification (vlan) ...
../../tests/ofproto-dpif.at:8009: ovsdb-tool create conf.db $abs_top_srcdir/vswitchd/vswitch.ovsschema
../../tests/ofproto-dpif.at:8009: ovsdb-server --detach --no-chdir --pidfile --log-file --remote=punix:$OVS_RUNDIR/db.sock
stderr:
2016-08-04T14:17:41Z|00001|vlog|INFO|opened log file /«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/ovsdb-server.log
../../tests/ofproto-dpif.at:8009: sed < stderr '
/vlog|INFO|opened log file/d
/ovsdb_server|INFO|ovsdb-server (Open vSwitch)/d'
../../tests/ofproto-dpif.at:8009: ovs-vsctl --no-wait init
../../tests/ofproto-dpif.at:8009: ovs-vswitchd --enable-dummy --disable-system --detach --no-chdir --pidfile --log-file -vvconn -vofproto_dpif -vunixctl
stderr:
2016-08-04T14:17:41Z|00001|vlog|INFO|opened log file /«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/ovs-vswitchd.log
2016-08-04T14:17:41Z|00002|ovs_numa|INFO|Discovered 4 CPU cores on NUMA node 0
2016-08-04T14:17:41Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 4 CPU cores
2016-08-04T14:17:41Z|00004|reconnect|INFO|unix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/db.sock: connecting...
2016-08-04T14:17:41Z|00005|reconnect|INFO|unix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/db.sock: connected
../../tests/ofproto-dpif.at:8009: 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
/netdev_linux|INFO|.*device has unknown hardware address family/d
/ofproto|INFO|datapath ID changed to fedcba9876543210/d
/dpdk|INFO|DPDK Disabled - to change this requires a restart./d'
../../tests/ofproto-dpif.at:8009: add_of_br 0 add-port br0 p1 -- set Interface p1 type=dummy ofport_request=1
../../tests/ofproto-dpif.at:8011: ovs-appctl vlog/set dpif:dbg dpif_netdev:dbg
../../tests/ofproto-dpif.at:8013: ovs-ofctl del-flows br0
../../tests/ofproto-dpif.at:8014: ovs-ofctl add-flow br0 in_port=1,actions=output:local
../../tests/ofproto-dpif.at:8020: ovs-appctl netdev-dummy/receive p1 'in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)'
dpif_netdev|DBG|flow_add: ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe recirc_id(0),in_port(1),eth_type(0x1234), actions:100
../../tests/ofproto-dpif.at:8029: ovs-appctl dpif/dump-flows br0 | strip_ufid | strip_used | sort
../../tests/ofproto-dpif.at:8036: ovs-ofctl del-flows br0
warped
warped
../../tests/ofproto-dpif.at:8045: ovs-appctl dpif/dump-flows br0 | strip_ufid | strip_used | sort
--- - 2016-08-04 14:17:45.260697793 +0000
+++ /«PKGBUILDDIR»/_debian/tests/testsuite.dir/at-groups/1149/stdout 2016-08-04 14:17:45.251408139 +0000
@@ -1,2 +1,2 @@
-recirc_id(0),in_port(1),eth_type(0x1234), packets:5, bytes:70, used:0.0s, actions:drop
+recirc_id(0),in_port(1),eth_type(0x1234), packets:5, bytes:70, used:0.0s, actions:userspace(pid=0,slow_path(controller))

ovsdb-server.log:
> 2016-08-04T14:17:41.412Z|00001|vlog|INFO|opened log file /«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/ovsdb-server.log
> 2016-08-04T14:17:41.421Z|00002|ovsdb_server|INFO|ovsdb-server (Open vSwitch) 2.5.90
ovs-vswitchd.log:
> 2016-08-04T14:17:41.870Z|00001|vlog|INFO|opened log file /«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/ovs-vswitchd.log
> 2016-08-04T14:17:41.877Z|00002|ovs_numa|INFO|Discovered 4 CPU cores on NUMA node 0
> 2016-08-04T14:17:41.877Z|00003|ovs_numa|INFO|Discovered 1 NUMA nodes and 4 CPU cores
> 2016-08-04T14:17:41.877Z|00004|reconnect|INFO|unix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/db.sock: connecting...
> 2016-08-04T14:17:41.877Z|00005|reconnect|INFO|unix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/db.sock: connected
> 2016-08-04T14:17:41.890Z|00006|bridge|INFO|ovs-vswitchd (Open vSwitch) 2.5.90
> 2016-08-04T14:17:42.213Z|00007|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath supports recirculation
> 2016-08-04T14:17:42.217Z|00008|ofproto_dpif|INFO|dummy@ovs-dummy: MPLS label stack length probed as 3
> 2016-08-04T14:17:42.217Z|00009|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath supports truncate action
> 2016-08-04T14:17:42.217Z|00010|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath supports unique flow ids
> 2016-08-04T14:17:42.217Z|00011|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath supports ct_state
> 2016-08-04T14:17:42.217Z|00012|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath supports ct_zone
> 2016-08-04T14:17:42.218Z|00013|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath supports ct_mark
> 2016-08-04T14:17:42.218Z|00014|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath supports ct_label
> 2016-08-04T14:17:42.218Z|00015|ofproto_dpif|INFO|dummy@ovs-dummy: Datapath does not support ct_state_nat
> 2016-08-04T14:17:42.220Z|00016|bridge|INFO|bridge br0: added interface p1 on port 1
> 2016-08-04T14:17:42.225Z|00017|bridge|INFO|bridge br0: added interface br0 on port 65534
> 2016-08-04T14:17:42.225Z|00018|bridge|INFO|bridge br0: using datapath ID fedcba9876543210
> 2016-08-04T14:17:42.225Z|00019|connmgr|INFO|br0: added service controller "punix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/1149/br0.mgmt"
> 2016-08-04T14:17:42.400Z|00020|unixctl|DBG|received request vlog/set["dpif:dbg","dpif_netdev:dbg"], id=0
> 2016-08-04T14:17:42.400Z|00021|unixctl|DBG|replying with success, id=0: ""
> 2016-08-04T14:17:42.586Z|00022|vconn|DBG|unix: sent (Success): OFPT_HELLO (OF1.6) (xid=0x1):
> version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06, 0x07
> 2016-08-04T14:17:42.587Z|00023|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2016-08-04T14:17:42.587Z|00024|vconn|DBG|unix: negotiated OpenFlow version 0x01 (we support version 0x07 and earlier, peer supports version 0x01)
> 2016-08-04T14:17:42.605Z|00025|vconn|DBG|unix: received: OFPT_FLOW_MOD (xid=0x2): DEL actions=drop
> 2016-08-04T14:17:42.610Z|00026|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST (xid=0x3):
> 2016-08-04T14:17:42.610Z|00027|vconn|DBG|unix: sent (Success): OFPT_BARRIER_REPLY (xid=0x3):
> 2016-08-04T14:17:42.617Z|00001|dpif(revalidator4)|DBG|dummy@ovs-dummy: get_stats success
> 2016-08-04T14:17:42.618Z|00001|dpif(revalidator5)|DBG|dummy@ovs-dummy: dumped all flows
> 2016-08-04T14:17:42.618Z|00002|dpif(revalidator4)|DBG|dummy@ovs-dummy: dumped all flows
> 2016-08-04T14:17:42.618Z|00003|dpif(revalidator4)|DBG|dummy@ovs-dummy: flow_dump_destroy success
> 2016-08-04T14:17:42.625Z|00028|connmgr|INFO|br0<->unix: 1 flow_mods in the last 0 s (1 deletes)
> 2016-08-04T14:17:42.812Z|00029|vconn|DBG|unix: sent (Success): OFPT_HELLO (OF1.6) (xid=0x2):
> version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06, 0x07
> 2016-08-04T14:17:42.820Z|00030|vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> 2016-08-04T14:17:42.820Z|00031|vconn|DBG|unix: negotiated OpenFlow version 0x01 (we support version 0x07 and earlier, peer supports version 0x01)
> 2016-08-04T14:17:42.821Z|00032|vconn|DBG|unix: received: OFPT_FLOW_MOD (xid=0x2): ADD in_port=1 actions=LOCAL
> 2016-08-04T14:17:42.822Z|00033|vconn|DBG|unix: received: OFPT_BARRIER_REQUEST (xid=0x3):
> 2016-08-04T14:17:42.822Z|00034|vconn|DBG|unix: sent (Success): OFPT_BARRIER_REPLY (xid=0x3):
> 2016-08-04T14:17:42.823Z|00035|connmgr|INFO|br0<->unix: 1 flow_mods in the last 0 s (1 adds)
> 2016-08-04T14:17:42.827Z|00004|dpif(revalidator4)|DBG|dummy@ovs-dummy: get_stats success
> 2016-08-04T14:17:42.827Z|00005|dpif(revalidator4)|DBG|dummy@ovs-dummy: dumped all flows
> 2016-08-04T14:17:42.828Z|00002|dpif(revalidator5)|DBG|dummy@ovs-dummy: dumped all flows
> 2016-08-04T14:17:42.828Z|00006|dpif(revalidator4)|DBG|dummy@ovs-dummy: flow_dump_destroy success
> 2016-08-04T14:17:43.081Z|00036|unixctl|DBG|received request vlog/set["PATTERN:ANY:%c|%p|%m"], id=0
> unixctl|DBG|replying with success, id=0: ""
> unixctl|DBG|received request time/stop[], id=0
> unixctl|DBG|replying with success, id=0: ""
> dpif|DBG|dummy@ovs-dummy: get_stats success
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|received request netdev-dummy/receive["p1","in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)"], id=0
> unixctl|DBG|replying with success, id=0: ""
> dpif_netdev|DBG|ovs-dummy: miss upcall:
> skb_priority(0),skb_mark(0),ct_state(0),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)
> vlan_tci=0x0000,dl_src=50:54:00:00:00:09,dl_dst=50:54:00:00:00:0a,dl_type=0x1234
> dpif_netdev|DBG|flow_add: ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe recirc_id(0),in_port(1),eth_type(0x1234), actions:100
> unixctl|DBG|received request netdev-dummy/receive["p1","in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)"], id=0
> unixctl|DBG|replying with success, id=0: ""
> dpif|DBG|dummy@ovs-dummy: flow_dump ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe <empty>, packets:1, bytes:14, used:0.000s
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|received request netdev-dummy/receive["p1","in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)"], id=0
> unixctl|DBG|replying with success, id=0: ""
> unixctl|DBG|received request dpif/dump-flows["br0"], id=0
> dpif|DBG|dummy@ovs-dummy: port_dump_start success
> dpif|DBG|dummy@ovs-dummy: port_dump_next success
> dpif|DBG|dummy@ovs-dummy: port_dump_next success
> dpif|DBG|dummy@ovs-dummy: port_dump_next success
> dpif|DBG|dummy@ovs-dummy: dumped all ports
> dpif|DBG|dummy@ovs-dummy: flow_dump ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe skb_priority(0/0),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),recirc_id(0),dp_hash(0/0),in_port(1),eth(src=50:54:00:00:00:09/00:00:00:00:00:00,dst=50:54:00:00:00:0a/00:00:00:00:00:00),eth_type(0x1234), packets:2, bytes:28, used:0.000s, actions:100
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|replying with success, id=0: "recirc_id(0),in_port(1),eth_type(0x1234), packets:2, bytes:28, used:0.000s, actions:100
> "
> vconn|DBG|unix: sent (Success): OFPT_HELLO (OF1.6) (xid=0x3):
> version bitmap: 0x01, 0x02, 0x03, 0x04, 0x05, 0x06, 0x07
> vconn|DBG|unix: received: OFPT_HELLO (xid=0x1):
> version bitmap: 0x01
> vconn|DBG|unix: negotiated OpenFlow version 0x01 (we support version 0x07 and earlier, peer supports version 0x01)
> vconn|DBG|unix: received: OFPT_FLOW_MOD (xid=0x2): DEL actions=drop
> dpif|DBG|dummy@ovs-dummy: flow_dump ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe <empty>, packets:2, bytes:28, used:0.000s
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> vconn|DBG|unix: received: OFPT_BARRIER_REQUEST (xid=0x3):
> dpif|DBG|dummy@ovs-dummy: put[modify] ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe skb_priority(0/0),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),recirc_id(0),dp_hash(0/0),in_port(1),eth(src=50:54:00:00:00:09/00:00:00:00:00:00,dst=50:54:00:00:00:0a/00:00:00:00:00:00),eth_type(0x1234), actions:userspace(pid=0,slow_path(controller))
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> vconn|DBG|unix: sent (Success): OFPT_BARRIER_REPLY (xid=0x3):
> connmgr|INFO|br0<->unix: 1 flow_mods in the last 0 s (1 deletes)
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|received request time/warp["500"], id=0
> unixctl|DBG|replying with success, id=0: "warped"
> dpif|DBG|dummy@ovs-dummy: get_stats success
> dpif|DBG|dummy@ovs-dummy: flow_dump ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe <empty>, packets:2, bytes:28, used:0.500s
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|received request time/warp["500"], id=0
> unixctl|DBG|replying with success, id=0: "warped"
> dpif|DBG|dummy@ovs-dummy: get_stats success
> dpif|DBG|dummy@ovs-dummy: flow_dump ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe <empty>, packets:2, bytes:28, used:1.000s
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|received request netdev-dummy/receive["p1","in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)"], id=0
> unixctl|DBG|replying with success, id=0: ""
> dpif_netdev|DBG|ovs-dummy: action upcall:
> skb_priority(0),skb_mark(0),ct_state(0),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)
> vlan_tci=0x0000,dl_src=50:54:00:00:00:09,dl_dst=50:54:00:00:00:0a,dl_type=0x1234
> unixctl|DBG|received request netdev-dummy/receive["p1","in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)"], id=0
> unixctl|DBG|replying with success, id=0: ""
> dpif_netdev|DBG|ovs-dummy: action upcall:
> skb_priority(0),skb_mark(0),ct_state(0),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)
> vlan_tci=0x0000,dl_src=50:54:00:00:00:09,dl_dst=50:54:00:00:00:0a,dl_type=0x1234
> unixctl|DBG|received request netdev-dummy/receive["p1","in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)"], id=0
> unixctl|DBG|replying with success, id=0: ""
> dpif_netdev|DBG|ovs-dummy: action upcall:
> skb_priority(0),skb_mark(0),ct_state(0),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(1),eth(src=50:54:00:00:00:09,dst=50:54:00:00:00:0a),eth_type(0x1234)
> vlan_tci=0x0000,dl_src=50:54:00:00:00:09,dl_dst=50:54:00:00:00:0a,dl_type=0x1234
> dpif|DBG|dummy@ovs-dummy: flow_dump ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe <empty>, packets:5, bytes:70, used:0.000s
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|received request dpif/dump-flows["br0"], id=0
> dpif|DBG|dummy@ovs-dummy: port_dump_start success
> dpif|DBG|dummy@ovs-dummy: port_dump_next success
> dpif|DBG|dummy@ovs-dummy: port_dump_next success
> dpif|DBG|dummy@ovs-dummy: port_dump_next success
> dpif|DBG|dummy@ovs-dummy: dumped all ports
> dpif|DBG|dummy@ovs-dummy: flow_dump ufid:e40ac5df-7148-4d24-a13d-81d944cfafbe skb_priority(0/0),skb_mark(0/0),ct_state(0/0),ct_zone(0/0),ct_mark(0/0),ct_label(0/0),recirc_id(0),dp_hash(0/0),in_port(1),eth(src=50:54:00:00:00:09/00:00:00:00:00:00,dst=50:54:00:00:00:0a/00:00:00:00:00:00),eth_type(0x1234), packets:5, bytes:70, used:0.000s, actions:userspace(pid=0,slow_path(controller))
> dpif|DBG|dummy@ovs-dummy: dumped all flows
> dpif|DBG|dummy@ovs-dummy: flow_dump_destroy success
> unixctl|DBG|replying with success, id=0: "recirc_id(0),in_port(1),eth_type(0x1234), packets:5, bytes:70, used:0.000s, actions:userspace(pid=0,slow_path(controller))
> "
1149. ofproto-dpif.at:8008: 1149. ofproto-dpif - in place modification (vlan) (ofproto-dpif.at:8008): FAILED (ofproto-dpif.at:8045)

# -*- compilation -*-
2214. ovn.at:1164: testing ovn -- vtep: 3 HVs, 1 VIFs/HV, 1 GW, 1 LS ...
creating ovn-sb database
creating ovn-nb database
starting ovn-northd
adding simulator 'main'
adding simulator 'hv1'
adding simulator 'hv2'
adding simulator 'vtep'
vtep-ctl: no port named br-vtep_n2
adding simulator 'hv3'
OK
OK
OK
OK
OK
OK
------ OVN dump ------
    switch cfbf6469-f49b-4795-9942-3ed0532477e1 (lsw0)
        port lp1
            addresses: ["f0:00:00:00:00:01"]
        port lp2
            addresses: ["f0:00:00:00:00:02"]
        port lp-vtep
            addresses: ["unknown"]
Chassis "hv1"
    hostname: "lgw01-23"
    Encap vxlan
        ip: "192.168.0.1"
    Encap geneve
        ip: "192.168.0.1"
    Port_Binding "lp1"
Chassis "hv2"
    hostname: "lgw01-23"
    Encap geneve
        ip: "192.168.0.2"
    Encap vxlan
        ip: "192.168.0.2"
    Port_Binding "lp2"
Chassis br-vtep
    Encap vxlan
        ip: "192.168.0.3"
------ hv1 dump ------
8a938559-6890-4022-96cf-d8536e123e0b
    Bridge br-phys
        Port br-phys
            Interface br-phys
                type: internal
                options: {rxq_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv1/br-phys-rx.pcap", tx_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv1/br-phys-tx.pcap"}
        Port "br-phys_n1"
            Interface "br-phys_n1"
                options: {rxq_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv1/br-phys_n1-rx.pcap", stream="unix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/main/hv1_br-phys.sock", tx_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv1/br-phys_n1-tx.pcap"}
    Bridge br-int
        fail_mode: secure
        Port "ovn-hv2-0"
            Interface "ovn-hv2-0"
                type: geneve
                options: {key=flow, remote_ip="192.168.0.2"}
        Port "vif1"
            Interface "vif1"
                options: {rxq_pcap="hv1/vif1-rx.pcap", tx_pcap="hv1/vif1-tx.pcap"}
        Port br-int
            Interface br-int
                type: internal
        Port "ovn-br-vte-0"
            Interface "ovn-br-vte-0"
                type: vxlan
                options: {key=flow, remote_ip="192.168.0.3"}
OFPT_FEATURES_REPLY (OF1.3) (xid=0x2): dpid:00002ada6d43384f
n_tables:254, n_buffers:256
capabilities: FLOW_STATS TABLE_STATS PORT_STATS GROUP_STATS QUEUE_STATS
OFPST_PORT_DESC reply (OF1.3) (xid=0x3):
 1(vif1): addr:aa:55:aa:55:00:0d
     config: PORT_DOWN
     state: LINK_DOWN
     speed: 0 Mbps now, 0 Mbps max
 2(ovn-hv2-0): addr:26:6d:77:fe:0e:1d
     config: 0
     state: 0
     speed: 0 Mbps now, 0 Mbps max
 3(ovn-br-vte-0): addr:66:44:12:92:6a:ac
     config: 0
     state: 0
     speed: 0 Mbps now, 0 Mbps max
 LOCAL(br-int): addr:2a:da:6d:43:38:4f
     config: PORT_DOWN
     state: LINK_DOWN
     speed: 0 Mbps now, 0 Mbps max
OFPT_GET_CONFIG_REPLY (OF1.3) (xid=0x5): frags=normal miss_send_len=0
OFPST_FLOW reply (OF1.3) (xid=0x2):
 cookie=0x0, duration=17.804s, table=0, n_packets=6, n_bytes=84, priority=100,in_port=1 actions=set_field:0x1->reg13,set_field:0x1->metadata,set_field:0x1->reg14,resubmit(,16)
 cookie=0x0, duration=15.633s, table=0, n_packets=3, n_bytes=42, priority=100,in_port=2 actions=move:NXM_NX_TUN_ID[0..23]->OXM_OF_METADATA[0..23],move:NXM_NX_TUN_METADATA0[16..30]->NXM_NX_REG14[0..14],move:NXM_NX_TUN_METADATA0[0..15]->NXM_NX_REG15[0..15],resubmit(,33)
 cookie=0x0, duration=17.811s, table=16, n_packets=0, n_bytes=0, priority=100,metadata=0x1,dl_src=01:00:00:00:00:00/01:00:00:00:00:00 actions=drop
 cookie=0x0, duration=17.806s, table=16, n_packets=0, n_bytes=0, priority=100,metadata=0x1,vlan_tci=0x1000/0x1000 actions=drop
 cookie=0x0, duration=17.814s, table=16, n_packets=6, n_bytes=84, priority=50,reg14=0x1,metadata=0x1 actions=resubmit(,17)
 cookie=0x0, duration=17.811s, table=16, n_packets=0, n_bytes=0, priority=50,reg14=0x2,metadata=0x1 actions=resubmit(,17)
 cookie=0x0, duration=17.807s, table=16, n_packets=0, n_bytes=0, priority=50,reg14=0x3,metadata=0x1 actions=resubmit(,17)
 cookie=0x0, duration=17.808s, table=17, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,18)
 cookie=0x0, duration=17.807s, table=18, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,19)
 cookie=0x0, duration=17.811s, table=19, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,20)
 cookie=0x0, duration=17.811s, table=20, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,21)
 cookie=0x0, duration=17.810s, table=21, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x1/0x1,metadata=0x1 actions=ct(table=22,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=17.806s, table=21, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x1/0x1,metadata=0x1 actions=ct(table=22,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=17.807s, table=21, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,22)
 cookie=0x0, duration=17.810s, table=22, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,23)
 cookie=0x0, duration=17.809s, table=23, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,24)
 cookie=0x0, duration=17.810s, table=24, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,25)
 cookie=0x0, duration=17.807s, table=24, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,25)
 cookie=0x0, duration=17.811s, table=24, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,25)
 cookie=0x0, duration=17.813s, table=25, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,26)
 cookie=0x0, duration=17.807s, table=26, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,27)
 cookie=0x0, duration=17.808s, table=27, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,28)
 cookie=0x0, duration=17.810s, table=28, n_packets=2, n_bytes=28, priority=100,metadata=0x1,dl_dst=01:00:00:00:00:00/01:00:00:00:00:00 actions=set_field:0xffff->reg15,resubmit(,32)
 cookie=0x0, duration=17.814s, table=28, n_packets=1, n_bytes=14, priority=50,metadata=0x1,dl_dst=f0:00:00:00:00:01 actions=set_field:0x1->reg15,resubmit(,32)
 cookie=0x0, duration=17.809s, table=28, n_packets=1, n_bytes=14, priority=50,metadata=0x1,dl_dst=f0:00:00:00:00:02 actions=set_field:0x2->reg15,resubmit(,32)
 cookie=0x0, duration=17.812s, table=28, n_packets=2, n_bytes=28, priority=0,metadata=0x1 actions=set_field:0xfffe->reg15,resubmit(,32)
 cookie=0x0, duration=15.416s, table=32, n_packets=2, n_bytes=28, priority=100,reg15=0xffff,metadata=0x1 actions=load:0x1->NXM_NX_TUN_ID[0..23],set_field:0xffff/0xffffffff->tun_metadata0,move:NXM_NX_REG14[0..14]->NXM_NX_TUN_METADATA0[16..30],output:2,resubmit(,33)
 cookie=0x0, duration=15.416s, table=32, n_packets=1, n_bytes=14, priority=100,reg15=0x2,metadata=0x1 actions=load:0x1->NXM_NX_TUN_ID[0..23],set_field:0x2/0xffffffff->tun_metadata0,move:NXM_NX_REG14[0..14]->NXM_NX_TUN_METADATA0[16..30],output:2
 cookie=0x0, duration=18.008s, table=32, n_packets=3, n_bytes=42, priority=0 actions=resubmit(,33)
 cookie=0x0, duration=17.813s, table=33, n_packets=4, n_bytes=56, priority=100,reg15=0xffff,metadata=0x1 actions=set_field:0x1->reg13,set_field:0x1->reg15,resubmit(,34),set_field:0xffff->reg15
 cookie=0x0, duration=17.803s, table=33, n_packets=2, n_bytes=28, priority=100,reg15=0x1,metadata=0x1 actions=set_field:0x1->reg13,resubmit(,34)
 cookie=0x0, duration=17.804s, table=34, n_packets=3, n_bytes=42, priority=100,reg10=0/0x1,reg14=0x1,reg15=0x1,metadata=0x1 actions=drop
 cookie=0x0, duration=18.008s, table=34, n_packets=3, n_bytes=42, priority=0 actions=set_field:0->reg0,set_field:0->reg1,set_field:0->reg2,set_field:0->reg3,set_field:0->reg4,set_field:0->reg5,set_field:0->reg6,set_field:0->reg7,set_field:0->reg8,set_field:0->reg9,resubmit(,48)
 cookie=0x0, duration=17.814s, table=48, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,49)
 cookie=0x0, duration=17.814s, table=49, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,50)
 cookie=0x0, duration=17.808s, table=50, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x1/0x1,metadata=0x1 actions=ct(table=51,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=17.807s, table=50, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x1/0x1,metadata=0x1 actions=ct(table=51,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=17.810s, table=50, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,51)
 cookie=0x0, duration=17.812s, table=51, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,52)
 cookie=0x0, duration=17.807s, table=52, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,53)
 cookie=0x0, duration=17.810s, table=53, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,54)
 cookie=0x0, duration=17.808s, table=53, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,54)
 cookie=0x0, duration=17.814s, table=53, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,54)
 cookie=0x0, duration=17.806s, table=54, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,55)
 cookie=0x0, duration=17.813s, table=55, n_packets=2, n_bytes=28, priority=100,metadata=0x1,dl_dst=01:00:00:00:00:00/01:00:00:00:00:00 actions=resubmit(,64)
 cookie=0x0, duration=17.814s, table=55, n_packets=1, n_bytes=14, priority=50,reg15=0x1,metadata=0x1 actions=resubmit(,64)
 cookie=0x0, duration=17.811s, table=55, n_packets=0, n_bytes=0, priority=50,reg15=0x3,metadata=0x1 actions=resubmit(,64)
 cookie=0x0, duration=17.807s, table=55, n_packets=0, n_bytes=0, priority=50,reg15=0x2,metadata=0x1 actions=resubmit(,64)
 cookie=0x0, duration=17.804s, table=64, n_packets=0, n_bytes=0, priority=100,reg10=0x1/0x1,reg15=0x1,metadata=0x1 actions=push:NXM_OF_IN_PORT[],set_field:0->in_port,resubmit(,65),pop:NXM_OF_IN_PORT[]
 cookie=0x0, duration=18.008s, table=64, n_packets=3, n_bytes=42, priority=0 actions=resubmit(,65)
 cookie=0x0, duration=17.804s, table=65, n_packets=3, n_bytes=42, priority=100,reg15=0x1,metadata=0x1 actions=output:1
------ hv2 dump ------
2277423e-8ad9-44f4-b374-b6d7b99e35b6
    Bridge br-phys
        Port "br-phys_n1"
            Interface "br-phys_n1"
                options: {rxq_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv2/br-phys_n1-rx.pcap", stream="unix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/main/hv2_br-phys.sock", tx_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv2/br-phys_n1-tx.pcap"}
        Port br-phys
            Interface br-phys
                type: internal
                options: {rxq_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv2/br-phys-rx.pcap", tx_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv2/br-phys-tx.pcap"}
    Bridge br-int
        fail_mode: secure
        Port br-int
            Interface br-int
                type: internal
        Port "ovn-br-vte-0"
            Interface "ovn-br-vte-0"
                type: vxlan
                options: {key=flow, remote_ip="192.168.0.3"}
        Port "vif2"
            Interface "vif2"
                options: {rxq_pcap="hv2/vif2-rx.pcap", tx_pcap="hv2/vif2-tx.pcap"}
        Port "ovn-hv1-0"
            Interface "ovn-hv1-0"
                type: geneve
                options: {key=flow, remote_ip="192.168.0.1"}
OFPT_FEATURES_REPLY (OF1.3) (xid=0x2): dpid:00003ad7b65cdc49
n_tables:254, n_buffers:256
capabilities: FLOW_STATS TABLE_STATS PORT_STATS GROUP_STATS QUEUE_STATS
OFPST_PORT_DESC reply (OF1.3) (xid=0x3):
 1(vif2): addr:aa:55:aa:55:00:0e
     config: PORT_DOWN
     state: LINK_DOWN
     speed: 0 Mbps now, 0 Mbps max
 3(ovn-br-vte-0): addr:76:db:d3:f8:ea:4f
     config: 0
     state: 0
     speed: 0 Mbps now, 0 Mbps max
 4(ovn-hv1-0): addr:d6:2d:8a:31:4c:6e
     config: 0
     state: 0
     speed: 0 Mbps now, 0 Mbps max
 LOCAL(br-int): addr:3a:d7:b6:5c:dc:49
     config: PORT_DOWN
     state: LINK_DOWN
     speed: 0 Mbps now, 0 Mbps max
OFPT_GET_CONFIG_REPLY (OF1.3) (xid=0x5): frags=normal miss_send_len=0
OFPST_FLOW reply (OF1.3) (xid=0x2):
 cookie=0x0, duration=16.130s, table=0, n_packets=6, n_bytes=84, priority=100,in_port=1 actions=set_field:0x1->reg13,set_field:0x1->metadata,set_field:0x2->reg14,resubmit(,16)
 cookie=0x0, duration=11.224s, table=0, n_packets=3, n_bytes=42, priority=100,in_port=4 actions=move:NXM_NX_TUN_ID[0..23]->OXM_OF_METADATA[0..23],move:NXM_NX_TUN_METADATA0[16..30]->NXM_NX_REG14[0..14],move:NXM_NX_TUN_METADATA0[0..15]->NXM_NX_REG15[0..15],resubmit(,33)
 cookie=0x0, duration=15.935s, table=16, n_packets=0, n_bytes=0, priority=100,metadata=0x1,dl_src=01:00:00:00:00:00/01:00:00:00:00:00 actions=drop
 cookie=0x0, duration=15.931s, table=16, n_packets=0, n_bytes=0, priority=100,metadata=0x1,vlan_tci=0x1000/0x1000 actions=drop
 cookie=0x0, duration=15.937s, table=16, n_packets=0, n_bytes=0, priority=50,reg14=0x1,metadata=0x1 actions=resubmit(,17)
 cookie=0x0, duration=15.936s, table=16, n_packets=6, n_bytes=84, priority=50,reg14=0x2,metadata=0x1 actions=resubmit(,17)
 cookie=0x0, duration=15.932s, table=16, n_packets=0, n_bytes=0, priority=50,reg14=0x3,metadata=0x1 actions=resubmit(,17)
 cookie=0x0, duration=15.932s, table=17, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,18)
 cookie=0x0, duration=15.932s, table=18, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,19)
 cookie=0x0, duration=15.936s, table=19, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,20)
 cookie=0x0, duration=15.936s, table=20, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,21)
 cookie=0x0, duration=15.935s, table=21, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x1/0x1,metadata=0x1 actions=ct(table=22,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=15.932s, table=21, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x1/0x1,metadata=0x1 actions=ct(table=22,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=15.932s, table=21, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,22)
 cookie=0x0, duration=15.935s, table=22, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,23)
 cookie=0x0, duration=15.933s, table=23, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,24)
 cookie=0x0, duration=15.935s, table=24, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,25)
 cookie=0x0, duration=15.932s, table=24, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,25)
 cookie=0x0, duration=15.936s, table=24, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,25)
 cookie=0x0, duration=15.937s, table=25, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,26)
 cookie=0x0, duration=15.932s, table=26, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,27)
 cookie=0x0, duration=15.933s, table=27, n_packets=6, n_bytes=84, priority=0,metadata=0x1 actions=resubmit(,28)
 cookie=0x0, duration=15.935s, table=28, n_packets=2, n_bytes=28, priority=100,metadata=0x1,dl_dst=01:00:00:00:00:00/01:00:00:00:00:00 actions=set_field:0xffff->reg15,resubmit(,32)
 cookie=0x0, duration=15.937s, table=28, n_packets=1, n_bytes=14, priority=50,metadata=0x1,dl_dst=f0:00:00:00:00:01 actions=set_field:0x1->reg15,resubmit(,32)
 cookie=0x0, duration=15.933s, table=28, n_packets=1, n_bytes=14, priority=50,metadata=0x1,dl_dst=f0:00:00:00:00:02 actions=set_field:0x2->reg15,resubmit(,32)
 cookie=0x0, duration=15.937s, table=28, n_packets=2, n_bytes=28, priority=0,metadata=0x1 actions=set_field:0xfffe->reg15,resubmit(,32)
 cookie=0x0, duration=15.936s, table=32, n_packets=1, n_bytes=14, priority=100,reg15=0x1,metadata=0x1 actions=load:0x1->NXM_NX_TUN_ID[0..23],set_field:0x1/0xffffffff->tun_metadata0,move:NXM_NX_REG14[0..14]->NXM_NX_TUN_METADATA0[16..30],output:4
 cookie=0x0, duration=16.130s, table=32, n_packets=2, n_bytes=28, priority=100,reg15=0xffff,metadata=0x1 actions=load:0x1->NXM_NX_TUN_ID[0..23],set_field:0xffff/0xffffffff->tun_metadata0,move:NXM_NX_REG14[0..14]->NXM_NX_TUN_METADATA0[16..30],output:4,resubmit(,33)
 cookie=0x0, duration=16.141s, table=32, n_packets=3, n_bytes=42, priority=0 actions=resubmit(,33)
 cookie=0x0, duration=15.937s, table=33, n_packets=4, n_bytes=56, priority=100,reg15=0xffff,metadata=0x1 actions=set_field:0x1->reg13,set_field:0x2->reg15,resubmit(,34),set_field:0xffff->reg15
 cookie=0x0, duration=15.931s, table=33, n_packets=2, n_bytes=28, priority=100,reg15=0x2,metadata=0x1 actions=set_field:0x1->reg13,resubmit(,34)
 cookie=0x0, duration=15.929s, table=34, n_packets=3, n_bytes=42, priority=100,reg10=0/0x1,reg14=0x2,reg15=0x2,metadata=0x1 actions=drop
 cookie=0x0, duration=16.141s, table=34, n_packets=3, n_bytes=42, priority=0 actions=set_field:0->reg0,set_field:0->reg1,set_field:0->reg2,set_field:0->reg3,set_field:0->reg4,set_field:0->reg5,set_field:0->reg6,set_field:0->reg7,set_field:0->reg8,set_field:0->reg9,resubmit(,48)
 cookie=0x0, duration=15.937s, table=48, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,49)
 cookie=0x0, duration=15.937s, table=49, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,50)
 cookie=0x0, duration=15.932s, table=50, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x1/0x1,metadata=0x1 actions=ct(table=51,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=15.932s, table=50, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x1/0x1,metadata=0x1 actions=ct(table=51,zone=NXM_NX_REG13[0..15])
 cookie=0x0, duration=15.935s, table=50, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,51)
 cookie=0x0, duration=15.936s, table=51, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,52)
 cookie=0x0, duration=15.932s, table=52, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,53)
 cookie=0x0, duration=15.935s, table=53, n_packets=0, n_bytes=0, priority=100,ipv6,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,54)
 cookie=0x0, duration=15.932s, table=53, n_packets=0, n_bytes=0, priority=100,ip,reg0=0x2/0x2,metadata=0x1 actions=ct(commit,zone=NXM_NX_REG13[0..15],exec(load:0->NXM_NX_CT_LABEL[0])),resubmit(,54)
 cookie=0x0, duration=15.937s, table=53, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,54)
 cookie=0x0, duration=15.931s, table=54, n_packets=3, n_bytes=42, priority=0,metadata=0x1 actions=resubmit(,55)
 cookie=0x0, duration=15.937s, table=55, n_packets=2, n_bytes=28, priority=100,metadata=0x1,dl_dst=01:00:00:00:00:00/01:00:00:00:00:00 actions=resubmit(,64)
 cookie=0x0, duration=15.937s, table=55, n_packets=0, n_bytes=0, priority=50,reg15=0x1,metadata=0x1 actions=resubmit(,64)
 cookie=0x0, duration=15.936s, table=55, n_packets=0, n_bytes=0, priority=50,reg15=0x3,metadata=0x1 actions=resubmit(,64)
 cookie=0x0, duration=15.932s, table=55, n_packets=1, n_bytes=14, priority=50,reg15=0x2,metadata=0x1 actions=resubmit(,64)
 cookie=0x0, duration=15.929s, table=64, n_packets=0, n_bytes=0, priority=100,reg10=0x1/0x1,reg15=0x2,metadata=0x1 actions=push:NXM_OF_IN_PORT[],set_field:0->in_port,resubmit(,65),pop:NXM_OF_IN_PORT[]
 cookie=0x0, duration=16.141s, table=64, n_packets=3, n_bytes=42, priority=0 actions=resubmit(,65)
 cookie=0x0, duration=15.929s, table=65, n_packets=3, n_bytes=42, priority=100,reg15=0x2,metadata=0x1 actions=output:1
------ hv3 dump ------
819753f5-3bbf-454c-b99e-a8a31843e7fa
    Bridge br-phys
        Port "br-phys_n2"
            Interface "br-phys_n2"
                options: {rxq_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv3/br-phys_n2-rx.pcap", stream="unix:/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/main/hv3_br-phys.sock", tx_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv3/br-phys_n2-tx.pcap"}
        Port "vif3"
            Interface "vif3"
                options: {rxq_pcap="hv3/vif3-rx.pcap", tx_pcap="hv3/vif3-tx.pcap"}
        Port br-phys
            Interface br-phys
                type: internal
                options: {rxq_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv3/br-phys-rx.pcap", tx_pcap="/«PKGBUILDDIR»/_debian/tests/testsuite.dir/2214/hv3/br-phys-tx.pcap"}
../../tests/ovn.at:1320: as hv3 ovs-ofctl -O OpenFlow13 show br-int

checking packets in hv1/vif1-tx.pcap against 1.expected:
expected 6 packets, only received 3
../../tests/ovn.at:1326: sort $rcv_text
--- expout 2016-08-04 14:18:21.863408139 +0000
+++ /«PKGBUILDDIR»/_debian/tests/testsuite.dir/at-groups/2214/stdout 2016-08-04 14:18:21.875408139 +0000
@@ -1,6 +1,3 @@
 010000000000f0000000000202ff
-010000000000f0000000000303ff
 f00000000001f000000000020021
-f00000000001f000000000030031
 fffffffffffff0000000000202ff
-fffffffffffff0000000000303ff
2214. ovn.at:1164: 2214. ovn -- vtep: 3 HVs, 1 VIFs/HV, 1 GW, 1 LS (ovn.at:1164): FAILED (ovn.at:1326)

Revision history for this message
Christian Ehrhardt  (paelzer) wrote :

Reproduced now.
I had 3 on the initial parralel run.

  15: bfd - bfd decay
1149: ofproto-dpif - in place modification (vlan)
2214: ovn -- vtep: 3 HVs, 1 VIFs/HV, 1 GW, 1 LS

Of those on the rerun only 2214 kept showing up.

Revision history for this message
Christian Ehrhardt  (paelzer) wrote :

It seems it expects those packets twice, but gets them only once

checking packets in hv1/vif1-tx.pcap against 1.expected:
expected 6 packets, only received 3
../../tests/ovn.at:1326: sort $rcv_text
--- expout 2016-08-05 12:13:09.661688314 +0000
+++ /<<PKGBUILDDIR>>/_dpdk/tests/testsuite.dir/at-groups/2214/stdout 2016-08-05 12:13:09.661688314 +0000
@@ -1,6 +1,3 @@
 010000000000f0000000000202ff
-010000000000f0000000000303ff
 f00000000001f000000000020021
-f00000000001f000000000030031
 fffffffffffff0000000000202ff
-fffffffffffff0000000000303ff

Changed in openvswitch (Ubuntu):
status: New → Confirmed
Revision history for this message
Christian Ehrhardt  (paelzer) wrote :

Set up a lxd env similarly clean as the usual build env to hack in it.
Building with:
# deps
apt-get build-dep openvswitch
# extra deps recently added
apt-get install python-setuptools python3-setuptools python3-all python3-six
# build as d/rules
tar xzf openvswitch_2.6.0~git20160804.0a0f39d.orig.tar.gz
cd openvswitch
dquilt push -a
dh build --with autoreconf,python2,python3,systemd --parallel

Again only 2214 failed in this env, so lets check that first.
Can be rerun in tests/testsuite.dir/2214/ which is left after the fail.

James Page (james-page)
Changed in openvswitch (Ubuntu):
importance: Undecided → Medium
milestone: none → ubuntu-16.10
status: Confirmed → Triaged
Revision history for this message
Christian Ehrhardt  (paelzer) wrote :
Revision history for this message
Christian Ehrhardt  (paelzer) wrote :
James Page (james-page)
Changed in openvswitch (Ubuntu):
status: Triaged → Fix Committed
Revision history for this message
Launchpad Janitor (janitor) wrote :

This bug was fixed in the package openvswitch - 2.6.0~git20160912.dc61b4e-0ubuntu1

---------------
openvswitch (2.6.0~git20160912.dc61b4e-0ubuntu1) yakkety; urgency=medium

  * New upstream snapshot from branch-2.6 (LP: #1609846).
  * d/rules: Skip test 1866 on ppc64el.
  * d/rules: Re-enable all tests across other archs.

 -- James Page <email address hidden> Mon, 12 Sep 2016 22:42:46 +0100

Changed in openvswitch (Ubuntu):
status: Fix Committed → Fix Released
Revision history for this message
James Page (james-page) wrote :

Re-opening; a later set of builds of the same package version regressed - I suspect that these tests are timing sensitive, and when the builders are under load, we end up with race conditions - my uploads last night where done during a quiet period.

Changed in openvswitch (Ubuntu):
status: Fix Released → Triaged
Revision history for this message
James Page (james-page) wrote :

Still seeing the same failure occasionally:

## ------------------------ ##
## Summary of the failures. ##
## ------------------------ ##
Failed tests:
openvswitch 2.6.0 test suite test groups:

 NUM: FILE-NAME:LINE TEST-GROUP-NAME
      KEYWORDS

 2227: ovn.at:1620 ovn -- vtep: 3 HVs, 1 VIFs/HV, 1 GW, 1 LS
      vtep

Revision history for this message
James Page (james-page) wrote :

Current list for 2.6.0 snapshot:

15: bfd - bfd decay
1149: ofproto-dpif - in place modification (vlan)
1866: ovsdb-server/active-backup-role-switching
2227: ovn -- vtep: 3 HVs, 1 VIFs/HV, 1 GW, 1 LS vtep

Revision history for this message
James Page (james-page) wrote :

2.7.0-0ubuntu1 is running the full i386 test suite with no skips; Marked Fix Released.

Changed in openvswitch (Ubuntu):
milestone: ubuntu-16.10 → none
status: Triaged → Fix Released
To post a comment you must log in.
This report contains Public information  
Everyone can see this information.
Subscribing...

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.