[ovs-discuss] ovs-vswitchd disconnecting UNIX socket

[Ben Warren]

Hi,

I’m seeing the ovs-vswitchd process disconnect its UNIX socket, and am wondering if it’s anything to worry about.  My Openflow client is able to re-attach and work again, and it only seems to be at startup time.

Here’s the switch log (/var/log/openvswitch/ovs-vswitchd.log:

=====
2016-04-23T05:39:47.414Z|01759|connmgr|INFO|br0: added service controller "punix:/var/run/openvswitch/br0.mgmt"
2016-04-23T05:39:47.414Z|01760|netdev_linux|WARN|lan0: removing policing failed: Operation not supported
2016-04-23T05:39:47.415Z|01761|netdev_linux|WARN|bond0: removing policing failed: Operation not supported
2016-04-23T05:39:47.419Z|01762|netdev_linux|WARN|br0: removing policing failed: Operation not supported
2016-04-23T05:39:47.419Z|01763|netdev_linux|WARN|lan0: removing policing failed: Operation not supported
2016-04-23T05:39:47.419Z|01764|netdev_linux|WARN|bond0: removing policing failed: Operation not supported
2016-04-23T05:39:47.496Z|01765|bridge|INFO|bridge br0: added interface dock0 on port 1
2016-04-23T05:39:47.496Z|01766|bridge|INFO|bridge br0: using datapath ID 0000dc3979807002
2016-04-23T05:39:47.496Z|01767|rconn|INFO|br0<->unix: disconnecting
2016-04-23T05:39:47.496Z|01768|netdev_linux|WARN|br0: removing policing failed: Operation not supported
=====

As you can see, the disconnects happen when the datapath ID changes, presumably due to adding interfaces?  Only the addition of the first two interfaces seem to bring it down.

On the client side, I’m really confused.  As you can see, I re-open the connection with a HELLO message, and the HELLO response comes back with an earlier XID (0x80 vs. the expected 0x86).  Message 0x83 was a BARRIER response, and a valid BARRIER reply was received, so it would seem that messages after 0x80 were accepted:

=====
"Timestamp": "2016-04-23T05:39:47.426776Z", "Message": "SENDING MESSAGE []byte{0x4, 0x0, 0x0, 0x10, 0x0, 0x0, 0x0, 0x1, 0x0, 0x1, 0x0, 0x8, 0x0, 0x0, 0x0, 0x10}"}
"Timestamp": "2016-04-23T05:39:47.427572Z", "Message": "RECEIVED        []byte{0x4, 0x0, 0x0, 0x8, 0x0, 0x0, 0x0, 0x7f}"}
"Timestamp": "2016-04-23T05:39:47.428489Z", "Message": "SENDING MESSAGE []byte{0x4, 0x5, 0x0, 0x8, 0x0, 0x0, 0x0, 0x80}"}
"Timestamp": "2016-04-23T05:39:47.430697Z", "Message": "RECEIVED        []byte{0x4, 0x6, 0x0, 0x20, 0x0, 0x0, 0x0, 0x80}"}
"Timestamp": "2016-04-23T05:39:47.431378Z", "Message": "SENDING MESSAGE []byte{0x4, 0x7, 0x0, 0x8, 0x0, 0x0, 0x0, 0x81}"}
"Timestamp": "2016-04-23T05:39:47.432263Z", "Message": "RECEIVED        []byte{0x4, 0x8, 0x0, 0xc, 0x0, 0x0, 0x0, 0x81}"}
"Timestamp": "2016-04-23T05:39:47.432632Z", "Message": "SENDING MESSAGE []byte{0x4, 0x9, 0x0, 0xc, 0x0, 0x0, 0x0, 0x82, 0x0, 0x3, 0x0, 0x0}"}
"Timestamp": "2016-04-23T05:39:47.433847Z", "Message": "SENDING MESSAGE []byte{0x4, 0x14, 0x0, 0x8, 0x0, 0x0, 0x0, 0x83}"}
"Timestamp": "2016-04-23T05:39:47.435925Z", "Message": "RECEIVED        []byte{0x4, 0x15, 0x0, 0x8, 0x0, 0x0, 0x0, 0x83}"}
"Timestamp": "2016-04-23T05:39:47.436905Z", "Message": "SENDING MESSAGE []byte{0x4, 0x7, 0x0, 0x8, 0x0, 0x0, 0x0, 0x84}"}
"Timestamp": "2016-04-23T05:39:47.437943Z", "Message": "RECEIVED        []byte{0x4, 0x8, 0x0, 0xc, 0x0, 0x0, 0x0, 0x84}"}
"Timestamp": "2016-04-23T05:39:47.438457Z", "Message": "ovs-vsctl add-port br0 dock0"}
"Timestamp": "2016-04-23T05:39:47.509736Z", "Message": "SENDING MESSAGE []byte{0x4, 0x12, 0x0, 0x10, 0x0, 0x0, 0x0, 0x85, 0x0, 0xd, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0}"}
"Timestamp": "2016-04-23T05:39:47.510679Z", "Message": "Message send failed []byte{0x4, 0x12, 0x0, 0x10, 0x0, 0x0, 0x0, 0x85, 0x0, 0xd, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0}: write unix @-\u003e/var/run/openvswitch/br0.mgmt: write: broken pipe"}
"Timestamp": "2016-04-23T05:39:49.511323Z", "Message": "Re-opening the OVS socket connection"}
"Timestamp": "2016-04-23T05:39:49.511959Z", "Message": "SENDING MESSAGE []byte{0x4, 0x0, 0x0, 0x10, 0x0, 0x0, 0x0, 0x86, 0x0, 0x1, 0x0, 0x8, 0x0, 0x0, 0x0, 0x10}"}
"Timestamp": "2016-04-23T05:39:49.512722Z", "Message": "RECEIVED        []byte{0x4, 0x0, 0x0, 0x8, 0x0, 0x0, 0x0, 0x80}"}
=====

The code on both switch and client is from top-of-tree 2.5 branch.  I’m using ‘ovs-vsctl’ from the command line, and the OF client is code I’ve written that links agains libopenvswitch.so (same code base as the server).

thanks,
Ben
-------------- next part --------------
A non-text attachment was scrubbed...
Name: smime.p7s
Type: application/pkcs7-signature
Size: 3583 bytes
Desc: not available
URL: <http://openvswitch.org/pipermail/ovs-discuss/attachments/20160422/c0905e56/attachment.p7s>