[ovs-discuss] ovs-vsctl adding dpdk ports hangs

Shivaram Mysore shivaram.mysore at gmail.com
Sun Mar 26 05:51:25 UTC 2017


Thanks Guru.

Upon further investigation, ovs is crashing.  Any thoughts on what could be
the issue or how I can get better debug info?

I have reverted to using DPDK 16.11 stable as suggested in 2.7
documentation.

$ *sudo ovs-vswitchd unix:$DB_SOCK --pidfile -v --detach --log-file*
2017-03-26T05:43:17Z|00001|vlog|INFO|opened log file
/usr/local/var/log/openvswitch/ovs-vswitchd.log
2017-03-26T05:43:17Z|00002|daemon_unix|DBG|/usr/local/var/run/openvswitch/ovs-vswitchd.pid:
deleted stale pidfile
2017-03-26T05:43:17Z|00003|reconnect|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
entering BACKOFF
2017-03-26T05:43:17Z|00004|hmap|DBG|lib/ovs-numa.c:117: 6 nodes in bucket
(32 nodes, 16 buckets)
2017-03-26T05:43:17Z|00005|ovs_numa|INFO|Discovered 36 CPU cores on NUMA
node 0
2017-03-26T05:43:17Z|00006|ovs_numa|INFO|Discovered 36 CPU cores on NUMA
node 1
2017-03-26T05:43:17Z|00007|ovs_numa|INFO|Discovered 2 NUMA nodes and 72 CPU
cores
2017-03-26T05:43:17Z|00008|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connecting...
2017-03-26T05:43:17Z|00009|reconnect|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
entering CONNECTING
2017-03-26T05:43:17Z|00010|poll_loop|DBG|wakeup due to [POLLOUT] on fd 11
(<->/usr/local/var/run/openvswitch/db.sock) at lib/stream-fd.c:151
2017-03-26T05:43:17Z|00011|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connected
2017-03-26T05:43:17Z|00012|reconnect|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
entering ACTIVE
2017-03-26T05:43:17Z|00013|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
send request, method="get_schema", params=["Open_vSwitch"], id=0
2017-03-26T05:43:17Z|00014|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
send request, method="lock", params=["ovs_vswitchd"], id=1
2017-03-26T05:43:17Z|00015|poll_loop|DBG|wakeup due to [POLLIN] on fd 11
(<->/usr/local/var/run/openvswitch/db.sock) at lib/stream-fd.c:155
2017-03-26T05:43:17Z|00016|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
received reply, result={"cksum":"3374030633
22987","name":"Open_vSwitch","version":"7.14.0","tables":{"Controller":{"columns":{"is_connected":{"ephemeral":true,"type":"boolean"},"connection_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["in-band","out-of-band"]]}}},"local_gateway":{"type":{"min":0,"key":"string"}},"enable_async_messages":{"type":{"min":0,"key":"boolean"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"local_netmask":{"type":{"min":0,"key":"string"}},"controller_burst_limit":{"type":{"min":0,"key":{"minInteger":25,"type":"integer"}}},"controller_rate_limit":{"type":{"min":0,"key":{"minInteger":100,"type":"integer"}}},"local_ip":{"type":{"min":0,"key":"string"}},"role":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["master","other","slave"]]}}},"target":{"type":"string"},"max_backoff":{"type":{"min":0,"key":{"minInteger":1000,"type":"integer"}}},"inactivity_probe":{"type":{"min":0,"key":"integer"}}}},"Bridge":{"indexes":[["name"]],"columns":{"name":{"mutable":false,"type":"string"},"flood_vlans":{"type":{"max":4096,"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}},"auto_attach":{"type":{"min":0,"key":{"type":"uuid","refTable":"AutoAttach"}}},"ports":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Port"}}},"stp_enable":{"type":"boolean"},"rstp_enable":{"type":"boolean"},"fail_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["secure","standalone"]]}}},"rstp_status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"flow_tables":{"type":{"max":"unlimited","min":0,"value":{"type":"uuid","refTable":"Flow_Table"},"key":{"minInteger":0,"type":"integer","maxInteger":254}}},"netflow":{"type":{"min":0,"key":{"type":"uuid","refTable":"NetFlow"}}},"datapath_type":{"type":"string"},"controller":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Controller"}}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ipfix":{"type":{"min":0,"key":{"type":"uuid","refTable":"IPFIX"}}},"datapath_id":{"ephemeral":true,"type":{"min":0,"key":"string"}},"mirrors":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Mirror"}}},"mcast_snooping_enable":{"type":"boolean"},"datapath_version":{"type":"string"},"sflow":{"type":{"min":0,"key":{"type":"uuid","refTable":"sFlow"}}},"protocols":{"type":{"max":"unlimited","min":0,"key":{"type":"string","enum":["set",["OpenFlow10","OpenFlow11","OpenFlow12","OpenFlow13","OpenFlow14","OpenFlow15","OpenFlow16"]]}}}}},"Queue":{"isRoot":true,"columns":{"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"dscp":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":63}}}}},"Open_vSwitch":{"maxRows":1,"isRoot":true,"columns":{"manager_options":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Manager"}}},"bridges":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Bridge"}}},"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ovs_version":{"type":{"min":0,"key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cur_cfg":{"type":"integer"},"next_cfg":{"type":"integer"},"iface_types":{"type":{"max":"unlimited","min":0,"key":"string"}},"datapath_types":{"type":{"max":"unlimited","min":0,"key":"string"}},"ssl":{"type":{"min":0,"key":{"type":"uuid","refTable":"SSL"}}},"system_version":{"type":{"min":0,"key":"string"}},"db_version":{"type":{"min":0,"key":"string"}},"system_type":{"type":{"min":0,"key":"string"}}}},"NetFlow":{"columns":{"active_timeout":{"type":{"key":{"minInteger":-1,"type":"integer"}}},"add_id_to_interface":{"type":"boolean"},"engine_id":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":255}}},"engine_type":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":255}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"targets":{"type":{"max":"unlimited","key":"string"}}}},"IPFIX":{"columns":{"obs_point_id":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"cache_active_timeout":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4200}}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"sampling":{"type":{"min":0,"key":{"minInteger":1,"type":"integer","maxInteger":4294967295}}},"targets":{"type":{"max":"unlimited","min":0,"key":"string"}},"obs_domain_id":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"cache_max_flows":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}}}},"QoS":{"isRoot":true,"columns":{"queues":{"type":{"max":"unlimited","min":0,"value":{"type":"uuid","refTable":"Queue"},"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"type":{"type":"string"}}},"Port":{"indexes":[["name"]],"columns":{"protected":{"type":"boolean"},"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"name":{"mutable":false,"type":"string"},"bond_downdelay":{"type":"integer"},"mac":{"type":{"min":0,"key":"string"}},"fake_bridge":{"type":"boolean"},"trunks":{"type":{"max":4096,"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}},"tag":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}},"rstp_status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"bond_updelay":{"type":"integer"},"bond_active_slave":{"type":{"min":0,"key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"bond_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["active-backup","balance-slb","balance-tcp"]]}}},"qos":{"type":{"min":0,"key":{"type":"uuid","refTable":"QoS"}}},"rstp_statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"vlan_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["access","native-tagged","native-untagged","trunk"]]}}},"interfaces":{"type":{"max":"unlimited","key":{"type":"uuid","refTable":"Interface"}}},"bond_fake_iface":{"type":"boolean"},"lacp":{"type":{"min":0,"key":{"type":"string","enum":["set",["active","off","passive"]]}}}}},"sFlow":{"columns":{"agent":{"type":{"min":0,"key":"string"}},"header":{"type":{"min":0,"key":"integer"}},"polling":{"type":{"min":0,"key":"integer"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"targets":{"type":{"max":"unlimited","key":"string"}},"sampling":{"type":{"min":0,"key":"integer"}}}},"SSL":{"maxRows":1,"columns":{"bootstrap_ca_cert":{"type":"boolean"},"private_key":{"type":"string"},"certificate":{"type":"string"},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ca_cert":{"type":"string"}}},"Flow_Sample_Collector_Set":{"isRoot":true,"indexes":[["id","bridge"]],"columns":{"id":{"type":{"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ipfix":{"type":{"min":0,"key":{"type":"uuid","refTable":"IPFIX"}}},"bridge":{"type":{"key":{"type":"uuid","refTable":"Bridge"}}}}},"Mirror":{"columns":{"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"select_all":{"type":"boolean"},"name":{"type":"string"},"output_vlan":{"type":{"min":0,"key":{"minInteger":1,"type":"integer","maxInteger":4095}}},"select_dst_port":{"type":{"max":"unlimited","min":0,"key":{"refType":"weak","refTable":"Port","type":"uuid"}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"select_src_port":{"type":{"max":"unlimited","min":0,"key":{"refType":"weak","refTable":"Port","type":"uuid"}}},"snaplen":{"type":{"min":0,"key":{"minInteger":14,"type":"integer","maxInteger":65535}}},"output_port":{"type":{"min":0,"key":{"refType":"weak","refTable":"Port","type":"uuid"}}},"select_vlan":{"type":{"max":4096,"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}}}},"Flow_Table":{"columns":{"name":{"type":{"min":0,"key":"string"}},"prefixes":{"type":{"max":3,"min":0,"key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"groups":{"type":{"max":"unlimited","min":0,"key":"string"}},"flow_limit":{"type":{"min":0,"key":{"minInteger":0,"type":"integer"}}},"overflow_policy":{"type":{"min":0,"key":{"type":"string","enum":["set",["evict","refuse"]]}}}}},"Interface":{"indexes":[["name"]],"columns":{"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"mac":{"type":{"min":0,"key":"string"}},"options":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"bfd_status":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cfm_health":{"ephemeral":true,"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":100}}},"ofport":{"type":{"min":0,"key":"integer"}},"admin_state":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["down","up"]]}}},"error":{"type":{"min":0,"key":"string"}},"cfm_fault_status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"key":"string"}},"lacp_current":{"ephemeral":true,"type":{"min":0,"key":"boolean"}},"mtu":{"ephemeral":true,"type":{"min":0,"key":"integer"}},"ofport_request":{"type":{"min":0,"key":{"minInteger":1,"type":"integer","maxInteger":65279}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"link_state":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["down","up"]]}}},"cfm_remote_opstate":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["down","up"]]}}},"cfm_fault":{"ephemeral":true,"type":{"min":0,"key":"boolean"}},"link_speed":{"ephemeral":true,"type":{"min":0,"key":"integer"}},"duplex":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["full","half"]]}}},"ingress_policing_rate":{"type":{"key":{"minInteger":0,"type":"integer"}}},"name":{"mutable":false,"type":"string"},"mtu_request":{"type":{"min":0,"key":{"minInteger":1,"type":"integer"}}},"cfm_flap_count":{"type":{"min":0,"key":"integer"}},"ifindex":{"ephemeral":true,"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"type":{"type":"string"},"mac_in_use":{"ephemeral":true,"type":{"min":0,"key":"string"}},"link_resets":{"ephemeral":true,"type":{"min":0,"key":"integer"}},"lldp":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cfm_remote_mpids":{"ephemeral":true,"type":{"max":"unlimited","min":0,"key":"integer"}},"bfd":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cfm_mpid":{"type":{"min":0,"key":"integer"}},"ingress_policing_burst":{"type":{"key":{"minInteger":0,"type":"integer"}}}}},"AutoAttach":{"columns":{"mappings":{"type":{"max":"unlimited","min":0,"value":{"minInteger":0,"type":"integer","maxInteger":4095},"key":{"minInteger":0,"type":"integer","maxInteger":16777215}}},"system_name":{"type":"string"},"system_description":{"type":"string"}}},"Manager":{"indexes":[["target"]],"columns":{"connection_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["in-band","out-of-band"]]}}},"is_connected":{"ephemeral":true,"type":"boolean"},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"target":{"type":"string"},"max_backoff":{"type":{"min":0,"key":{"minInteger":1000,"type":"integer"}}},"inactivity_probe":{"type":{"min":0,"key":"integer"}}}}}},
id=0
2017-03-26T05:43:17Z|00017|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
send request, method="monitor_cond",
params=["Open_vSwitch","822a1e21-907f-496c-98e9-fafcde53ac11",{"Controller":{"columns":["connection_mode","controller_burst_limit","controller_rate_limit","enable_async_messages","inactivity_probe","is_connected","local_gateway","local_ip","local_netmask","max_backoff","other_config","role","status","target"]},"Bridge":{"columns":["auto_attach","controller","datapath_id","datapath_type","datapath_version","fail_mode","flood_vlans","flow_tables","ipfix","mcast_snooping_enable","mirrors","name","netflow","other_config","ports","protocols","rstp_enable","rstp_status","sflow","status","stp_enable"]},"Queue":{"columns":["dscp","other_config"]},"IPFIX":{"columns":["cache_active_timeout","cache_max_flows","obs_domain_id","obs_point_id","other_config","sampling","targets"]},"NetFlow":{"columns":["active_timeout","add_id_to_interface","engine_id","engine_type","targets"]},"Open_vSwitch":{"columns":["bridges","cur_cfg","datapath_types","iface_types","manager_options","next_cfg","other_config","ssl","statistics"]},"QoS":{"columns":["other_config","queues","type"]},"Port":{"columns":["bond_active_slave","bond_downdelay","bond_fake_iface","bond_mode","bond_updelay","fake_bridge","interfaces","lacp","mac","name","other_config","protected","qos","rstp_statistics","rstp_status","statistics","status","tag","trunks","vlan_mode"]},"SSL":{"columns":["bootstrap_ca_cert","ca_cert","certificate","private_key"]},"sFlow":{"columns":["agent","header","polling","sampling","targets"]},"Flow_Sample_Collector_Set":{"columns":["bridge","id","ipfix"]},"Flow_Table":{"columns":["external_ids","flow_limit","groups","name","overflow_policy","prefixes"]},"Mirror":{"columns":["name","output_port","output_vlan","select_all","select_dst_port","select_src_port","select_vlan","snaplen","statistics"]},"Interface":{"columns":["admin_state","bfd","bfd_status","cfm_fault","cfm_fault_status","cfm_flap_count","cfm_health","cfm_mpid","cfm_remote_mpids","cfm_remote_opstate","duplex","error","ifindex","ingress_policing_burst","ingress_policing_rate","lacp_current","link_resets","link_speed","link_state","lldp","mac","mac_in_use","mtu","mtu_request","name","ofport","ofport_request","options","other_config","statistics","status","type"]},"AutoAttach":{"columns":["mappings","system_description","system_name"]},"Manager":{"columns":["connection_mode","other_config","target"]}}],
id=2
2017-03-26T05:43:17Z|00018|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
received reply, result={"locked":true}, id=1
2017-03-26T05:43:17Z|00019|poll_loop|DBG|wakeup due to [POLLIN] on fd 11
(<->/usr/local/var/run/openvswitch/db.sock) at lib/stream-fd.c:155
2017-03-26T05:43:17Z|00020|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
received reply,
result={"Interface":{"e1cdb7cb-ce8c-4295-b1ae-5740b2544524":{"initial":{"mac_in_use":"fe:8f:2e:45:c5:41","link_resets":0,"name":"ovs-ip64-br0","statistics":["map",[["collisions",0],["rx_bytes",0],["rx_crc_err",0],["rx_dropped",0],["rx_errors",0],["rx_frame_err",0],["rx_over_err",0],["rx_packets",0],["tx_bytes",0],["tx_dropped",0],["tx_errors",0],["tx_packets",0]]],"mtu":1500,"ifindex":18,"status":["map",[["driver_name","tun"],["driver_version","1.6"],["firmware_version",""]]],"link_state":"down","type":"internal","link_speed":10000000,"ofport":65534,"duplex":"full","admin_state":"down"}},"02438858-c153-41d2-8e03-02a8fb07c64f":{"initial":{"name":"dpdk-p0","options":["map",[["dpdk-devargs","0000:82:00.0"]]],"type":"dpdk"}}},"Port":{"45465e63-9968-4486-845c-03b0acbd036b":{"initial":{"name":"dpdk-p0","interfaces":["uuid","02438858-c153-41d2-8e03-02a8fb07c64f"]}},"78d29fd3-ef96-4f22-89a8-e290efbc9b86":{"initial":{"name":"ovs-ip64-br0","interfaces":["uuid","e1cdb7cb-ce8c-4295-b1ae-5740b2544524"]}}},"Bridge":{"452e8ffc-fbd3-41c5-85ba-42a5eb921958":{"initial":{"name":"ovs-ip64-br0","ports":["set",[["uuid","45465e63-9968-4486-845c-03b0acbd036b"],["uuid","78d29fd3-ef96-4f22-89a8-e290efbc9b86"]]],"datapath_type":"netdev","datapath_id":"0000fe8f2e45c541","datapath_version":"<built-in>"}}},"Open_vSwitch":{"ef1929d5-2698-4e92-9599-e2a29b010d4d":{"initial":{"bridges":["uuid","452e8ffc-fbd3-41c5-85ba-42a5eb921958"],"iface_types":["set",["dpdk","dpdkr","dpdkvhostuser","dpdkvhostuserclient","geneve","gre","internal","lisp","patch","stt","system","tap","vxlan"]],"datapath_types":["set",["netdev","system"]],"other_config":["map",[["dpdk-init","true"]]],"cur_cfg":1,"next_cfg":2}}}},
id=2
2017-03-26T05:43:17Z|00021|dpdk|INFO|DPDK Enabled - initializing...
2017-03-26T05:43:17Z|00022|dpdk|INFO|No vhost-sock-dir provided -
defaulting to /usr/local/var/run/openvswitch
2017-03-26T05:43:17Z|00023|dpdk|INFO|EAL ARGS: ovs-vswitchd --socket-mem
1024,0 -c 0x00000001
EAL: Detected 72 lcore(s)
EAL: Probing VFIO support...
EAL: VFIO support initialized
EAL: PCI device 0000:01:00.0 on NUMA socket 0
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:01:00.1 on NUMA socket 0
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:01:00.2 on NUMA socket 0
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:01:00.3 on NUMA socket 0
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:81:00.0 on NUMA socket 1
EAL:   probe driver: 8086:10fb net_ixgbe
EAL: PCI device 0000:81:00.1 on NUMA socket 1
EAL:   probe driver: 8086:10fb net_ixgbe
EAL: PCI device 0000:82:00.0 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL:   using IOMMU type 1 (Type 1)
EAL: PCI device 0000:82:00.1 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:82:00.2 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:82:00.3 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:83:00.0 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:83:00.1 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:83:00.2 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
EAL: PCI device 0000:83:00.3 on NUMA socket 1
EAL:   probe driver: 8086:1521 net_e1000_igb
Zone 0: name:<rte_eth_dev_data>, phys:0x13ffced40, len:0x30100,
virt:0x7f9b3ffced40, socket_id:0, flags:0
2017-03-26T05:43:45Z|00024|dpdk|INFO|DPDK Enabled - initialized
2017-03-26T05:43:45Z|00025|hmap|DBG|lib/shash.c:112: 7 nodes in bucket (64
nodes, 32 buckets)
2017-03-26T05:43:45Z|00001|poll_loop(urcu3)|DBG|wakeup due to 0-ms timeout
2017-03-26T05:43:45Z|00026|netlink_socket|DBG|nl_sock_send__ (Success):
nl(len:17, type=26(family-defined), flags=305[REQUEST][ACK][DUMP], seq=1,
pid=2618663578
2017-03-26T05:43:45Z|00027|netlink_socket|DBG|nl_sock_recv__ (Success):
nl(len:52, type=24(family-defined), flags=2[MULTI], seq=1, pid=2618663578
2017-03-26T05:43:45Z|00028|netlink_socket|DBG|nl_sock_recv__ (Success):
nl(len:116, type=24(family-defined), flags=2[MULTI], seq=1, pid=2618663578
2017-03-26T05:43:45Z|00029|netlink_socket|DBG|nl_sock_recv__ (Success):
nl(len:20, type=3(done), flags=2[MULTI], seq=1, pid=2618663578 done(0)
2017-03-26T05:43:45Z|00001|conntrack(ct_clean4)|DBG|conntrack cleanup 0
entries in 0 msec
2017-03-26T05:43:45Z|00002|poll_loop(ct_clean4)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00003|conntrack(ct_clean4)|DBG|conntrack cleanup 0
entries in 0 msec
2017-03-26T05:43:45Z|00030|dpif|DBG|netdev at ovs-netdev: flow_flush success
2017-03-26T05:43:45Z|00031|dpif|DBG|netdev at ovs-netdev: port_dump_start
success
2017-03-26T05:43:45Z|00032|dpif|DBG|netdev at ovs-netdev: port_dump_next
success
2017-03-26T05:43:45Z|00033|dpif|DBG|netdev at ovs-netdev: dumped all ports
2017-03-26T05:43:45Z|00034|dpif_netdev|DBG|Creating dpcls 0x55f67bde9360
for in_port 0
2017-03-26T05:43:45Z|00035|dpif_netdev|DBG|Creating 1. subtable
0x55f67bde9530 for in_port 0
2017-03-26T05:43:45Z|00036|dpif_netdev|DBG|flow_add:
ufid:e1027d2d-7dcc-41d0-8959-83b811ec3fd1
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0x1),dp_hash(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45Z|00037|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),recirc_id(0x1),dp_hash(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00038|dpif_netdev|DBG|Destroying subtable
0x55f67bde9530 for in_port 0
2017-03-26T05:43:45Z|00039|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),recirc_id(0x1),dp_hash(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45Z|00040|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
supports recirculation
2017-03-26T05:43:45Z|00041|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdea250 for in_port 0
2017-03-26T05:43:45Z|00042|dpif_netdev|DBG|flow_add:
ufid:9721ff36-8638-4a41-8c56-68881785af6f
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=1),
actions:drop
2017-03-26T05:43:45Z|00043|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=1),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00044|dpif_netdev|DBG|Destroying subtable
0x55f67bdea250 for in_port 0
2017-03-26T05:43:45Z|00045|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=1)
2017-03-26T05:43:45Z|00046|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdeabf0 for in_port 0
2017-03-26T05:43:45Z|00047|dpif_netdev|DBG|flow_add:
ufid:02c0d9f7-7ad0-4cc9-8706-89f093c03915
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
actions:drop
2017-03-26T05:43:45Z|00048|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00049|dpif_netdev|DBG|Destroying subtable
0x55f67bdeabf0 for in_port 0
2017-03-26T05:43:45Z|00050|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1)
2017-03-26T05:43:45Z|00051|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdeb6a0 for in_port 0
2017-03-26T05:43:45Z|00002|poll_loop(urcu3)|DBG|wakeup due to [POLLIN] on
fd 45 (FIFO pipe:[1313046]) at lib/ovs-rcu.c:310
2017-03-26T05:43:45Z|00052|dpif_netdev|DBG|flow_add:
ufid:9398c63e-412a-4b48-9c09-cdd19524127e
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
actions:drop
2017-03-26T05:43:45Z|00053|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00054|dpif_netdev|DBG|Destroying subtable
0x55f67bdeb6a0 for in_port 0
2017-03-26T05:43:45Z|00055|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1)
2017-03-26T05:43:45Z|00056|ofproto_dpif|INFO|netdev at ovs-netdev: MPLS label
stack length probed as 3
2017-03-26T05:43:45Z|00057|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
supports truncate action
2017-03-26T05:43:45Z|00058|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdec030 for in_port 0
2017-03-26T05:43:45Z|00059|dpif_netdev|DBG|flow_add:
ufid:604b145b-df63-4a74-9af0-33e23db7c5cf
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234),
actions:drop
2017-03-26T05:43:45Z|00060|dpif|DBG|netdev at ovs-netdev: flow_get
ufid:604b145b-df63-4a74-9af0-33e23db7c5cf
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00061|dpif_netdev|DBG|Destroying subtable
0x55f67bdec030 for in_port 0
2017-03-26T05:43:45Z|00062|dpif|DBG|netdev at ovs-netdev: flow_del
ufid:604b145b-df63-4a74-9af0-33e23db7c5cf
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234)
2017-03-26T05:43:45Z|00063|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
supports unique flow ids
2017-03-26T05:43:45Z|00064|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdec9b0 for in_port 0
2017-03-26T05:43:45Z|00065|dpif_netdev|DBG|flow_add:
ufid:ae78bdb5-65ca-44c9-9516-de37a873d584
skb_priority(0),skb_mark(0),ct_state(+new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45Z|00066|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_state(0x1/0xff),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00067|dpif_netdev|DBG|Destroying subtable
0x55f67bdec9b0 for in_port 0
2017-03-26T05:43:45Z|00068|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_state(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45Z|00069|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
supports ct_state
2017-03-26T05:43:45Z|00070|dpif_netdev|DBG|Creating 1. subtable
0x55f67bded450 for in_port 0
2017-03-26T05:43:45Z|00071|dpif_netdev|DBG|flow_add:
ufid:a4487d75-0146-4eb2-ad0e-9de01853bab1
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0x1),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45Z|00072|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_zone(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00073|dpif_netdev|DBG|Destroying subtable
0x55f67bded450 for in_port 0
2017-03-26T05:43:45Z|00074|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_zone(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45Z|00075|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
supports ct_zone
2017-03-26T05:43:45Z|00076|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdede50 for in_port 0
2017-03-26T05:43:45Z|00077|dpif_netdev|DBG|flow_add:
ufid:b82a810f-bc0e-4d81-ab17-d35b5ada3b48
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0x1),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45Z|00078|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_mark(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00079|dpif_netdev|DBG|Destroying subtable
0x55f67bdede50 for in_port 0
2017-03-26T05:43:45Z|00080|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_mark(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45Z|00081|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
supports ct_mark
2017-03-26T05:43:45Z|00082|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdee850 for in_port 0
2017-03-26T05:43:45Z|00083|dpif_netdev|DBG|flow_add:
ufid:9edc61b5-86f9-4e32-81d7-083196e2713a
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0x1),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45Z|00084|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_label(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45Z|00085|dpif_netdev|DBG|Destroying subtable
0x55f67bdee850 for in_port 0
2017-03-26T05:43:45Z|00086|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_label(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45Z|00087|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
supports ct_label
2017-03-26T05:43:45Z|00088|ofproto_dpif|INFO|netdev at ovs-netdev: Datapath
does not support ct_state_nat
2017-03-26T05:43:45Z|00003|poll_loop(urcu3)|DBG|wakeup due to [POLLIN] on
fd 45 (FIFO pipe:[1313046]) at lib/ovs-rcu.c:230
2017-03-26T05:43:45Z|00001|poll_loop(handler5)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler6)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler7)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler8)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler9)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler10)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler11)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler12)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler15)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler14)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler13)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler16)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler17)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler18)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler20)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler19)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler21)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler22)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler23)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler24)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler25)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler26)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler27)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler28)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler29)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler30)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler31)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler32)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler34)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler33)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler36)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler35)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler37)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler38)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler39)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler40)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler41)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler42)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler44)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler45)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler43)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler50)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler47)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler46)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler48)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler49)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler51)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler53)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler52)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler54)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler55)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler57)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(handler56)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator59)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator61)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|dpif(revalidator58)|DBG|netdev at ovs-netdev:
get_stats success
2017-03-26T05:43:45Z|00001|poll_loop(revalidator60)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator62)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00002|poll_loop(revalidator58)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator67)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator69)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator72)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator65)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator74)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator66)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator71)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00089|dpif_netdev|DBG|ovs-netdev: 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(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234)
vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,dl_type=0x1234
2017-03-26T05:43:45Z|00001|poll_loop(revalidator63)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator68)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator73)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|poll_loop(revalidator70)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00001|dpif(revalidator64)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|dpif(revalidator71)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00001|poll_loop(revalidator76)|DBG|wakeup due to 0-ms
timeout at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|poll_loop(revalidator60)|DBG|wakeup due to
[POLLIN] on fd 63 (FIFO pipe:[1298230]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|poll_loop(revalidator64)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45Z|00002|poll_loop(revalidator66)|DBG|wakeup due to
[POLLIN] on fd 85 (FIFO pipe:[1325360]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|poll_loop(revalidator72)|DBG|wakeup due to
[POLLIN] on fd 75 (FIFO pipe:[1291015]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|dpif(revalidator70)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00001|poll_loop(revalidator75)|DBG|wakeup due to
[POLLIN] on fd 83 (FIFO pipe:[1288179]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|dpif(revalidator65)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|dpif(revalidator63)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|dpif(revalidator74)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|poll_loop(revalidator69)|DBG|wakeup due to
[POLLIN] on fd 73 (FIFO pipe:[1307398]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|poll_loop(revalidator59)|DBG|wakeup due to
[POLLIN] on fd 59 (FIFO pipe:[1288174]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|dpif(revalidator60)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|dpif(revalidator76)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00003|dpif(revalidator72)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|poll_loop(revalidator67)|DBG|wakeup due to
[POLLIN] on fd 71 (FIFO pipe:[1345686]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|dpif(revalidator66)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00003|dpif(revalidator59)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|dpif(revalidator68)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00003|dpif(revalidator69)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|dpif(revalidator73)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00003|poll_loop(revalidator58)|DBG|wakeup due to
[POLLIN] on fd 69 (FIFO pipe:[1336468]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|poll_loop(revalidator61)|DBG|wakeup due to
[POLLIN] on fd 61 (FIFO pipe:[1338436]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00002|dpif(revalidator75)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00002|poll_loop(revalidator62)|DBG|wakeup due to
[POLLIN] on fd 65 (FIFO pipe:[1288178]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|dpif(revalidator67)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00004|dpif(revalidator58)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00003|dpif(revalidator61)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00003|dpif(revalidator62)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45Z|00004|poll_loop(revalidator67)|DBG|wakeup due to
[POLLIN] on fd 71 (FIFO pipe:[1345686]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator73)|DBG|wakeup due to
[POLLIN] on fd 87 (FIFO pipe:[1304278]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00004|poll_loop(revalidator62)|DBG|wakeup due to
[POLLIN] on fd 65 (FIFO pipe:[1288178]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00005|poll_loop(revalidator58)|DBG|wakeup due to
[POLLIN] on fd 69 (FIFO pipe:[1336468]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator75)|DBG|wakeup due to
[POLLIN] on fd 83 (FIFO pipe:[1288179]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00004|poll_loop(revalidator59)|DBG|wakeup due to
[POLLIN] on fd 59 (FIFO pipe:[1288174]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator70)|DBG|wakeup due to
[POLLIN] on fd 91 (FIFO pipe:[1345052]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00004|poll_loop(revalidator69)|DBG|wakeup due to
[POLLIN] on fd 73 (FIFO pipe:[1307398]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00004|poll_loop(revalidator66)|DBG|wakeup due to
[POLLIN] on fd 85 (FIFO pipe:[1325360]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator71)|DBG|wakeup due to
[POLLIN] on fd 81 (FIFO pipe:[1319252]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator65)|DBG|wakeup due to
[POLLIN] on fd 79 (FIFO pipe:[1336469]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator74)|DBG|wakeup due to
[POLLIN] on fd 77 (FIFO pipe:[1338437]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator68)|DBG|wakeup due to
[POLLIN] on fd 89 (FIFO pipe:[1326479]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator63)|DBG|wakeup due to
[POLLIN] on fd 67 (FIFO pipe:[1307397]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00004|poll_loop(revalidator60)|DBG|wakeup due to
[POLLIN] on fd 63 (FIFO pipe:[1298230]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00004|poll_loop(revalidator72)|DBG|wakeup due to
[POLLIN] on fd 75 (FIFO pipe:[1291015]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator76)|DBG|wakeup due to
[POLLIN] on fd 95 (FIFO pipe:[1297250]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00003|poll_loop(revalidator64)|DBG|wakeup due to
[POLLIN] on fd 93 (FIFO pipe:[1336470]) at lib/ovs-thread.c:312
2017-03-26T05:43:45Z|00090|dpif_netdev|INFO|Created 1 pmd threads on numa
node 0
2017-03-26T05:43:45Z|00091|dpif_netdev|INFO|Created 1 pmd threads on numa
node 1
2017-03-26T05:43:46Z|00002|daemon_unix|ERR|fork child died before signaling
startup (killed (Segmentation fault), core dumped)
ovs-vswitchd: could not detach from foreground session


#* tail -300 /usr/local/var/log/openvswitch/ovs-vswitchd.log*
2017-03-25T02:27:04.333Z|00018|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_label
2017-03-25T02:27:04.333Z|00019|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath does not support ct_state_nat
2017-03-25T02:27:04.378Z|00020|bridge|INFO|bridge ovs-ip64-br0: added
interface ovs-ip64-br0 on port 65534
2017-03-25T02:27:04.437Z|00021|dpif_netdev|INFO|Created 1 pmd threads on
numa node 0
2017-03-25T02:27:04.437Z|00022|dpif_netdev|INFO|Created 1 pmd threads on
numa node 1
2017-03-25T02:27:05.745Z|00002|daemon_unix|ERR|fork child died before
signaling startup (killed (Segmentation fault), core dumped)
2017-03-25T02:27:05.745Z|00003|daemon_unix|EMER|could not detach from
foreground session
2017-03-26T05:17:26.867Z|00001|vlog|INFO|opened log file
/usr/local/var/log/openvswitch/ovs-vswitchd.log
2017-03-26T05:17:26.870Z|00002|ovs_numa|INFO|Discovered 36 CPU cores on
NUMA node 0
2017-03-26T05:17:26.870Z|00003|ovs_numa|INFO|Discovered 36 CPU cores on
NUMA node 1
2017-03-26T05:17:26.870Z|00004|ovs_numa|INFO|Discovered 2 NUMA nodes and 72
CPU cores
2017-03-26T05:17:26.870Z|00005|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connecting...
2017-03-26T05:17:26.871Z|00006|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connected
2017-03-26T05:17:26.874Z|00007|dpdk|INFO|DPDK Enabled - initializing...
2017-03-26T05:17:26.874Z|00008|dpdk|INFO|No vhost-sock-dir provided -
defaulting to /usr/local/var/run/openvswitch
2017-03-26T05:17:26.874Z|00009|dpdk|INFO|EAL ARGS: ovs-vswitchd
--socket-mem 1024,0 -c 0x00000001
2017-03-26T05:17:54.680Z|00010|dpdk|INFO|DPDK Enabled - initialized
2017-03-26T05:17:54.683Z|00011|timeval|WARN|Unreasonably long 27809ms poll
interval (452ms user, 25384ms system)
2017-03-26T05:17:54.683Z|00012|timeval|WARN|faults: 828 minor, 7 major
2017-03-26T05:17:54.683Z|00013|timeval|WARN|disk: 1128 reads, 0 writes
2017-03-26T05:17:54.683Z|00014|timeval|WARN|context switches: 33 voluntary,
41 involuntary
2017-03-26T05:17:54.683Z|00015|coverage|INFO|Event coverage, avg rate over
last: 5 seconds, last minute, last hour,  hash=f4be763f:
2017-03-26T05:17:54.683Z|00016|coverage|INFO|bridge_reconfigure
0.0/sec     0.000/sec        0.0000/sec   total: 1
2017-03-26T05:17:54.683Z|00017|coverage|INFO|cmap_expand
 0.0/sec     0.000/sec        0.0000/sec   total: 9
2017-03-26T05:17:54.683Z|00018|coverage|INFO|miniflow_malloc
 0.0/sec     0.000/sec        0.0000/sec   total: 11
2017-03-26T05:17:54.683Z|00019|coverage|INFO|hmap_pathological
 0.0/sec     0.000/sec        0.0000/sec   total: 2
2017-03-26T05:17:54.683Z|00020|coverage|INFO|hmap_expand
 0.0/sec     0.000/sec        0.0000/sec   total: 377
2017-03-26T05:17:54.683Z|00021|coverage|INFO|txn_unchanged
 0.0/sec     0.000/sec        0.0000/sec   total: 2
2017-03-26T05:17:54.683Z|00022|coverage|INFO|txn_incomplete
0.0/sec     0.000/sec        0.0000/sec   total: 1
2017-03-26T05:17:54.683Z|00023|coverage|INFO|poll_create_node
0.0/sec     0.000/sec        0.0000/sec   total: 40
2017-03-26T05:17:54.683Z|00024|coverage|INFO|seq_change
0.0/sec     0.000/sec        0.0000/sec   total: 51
2017-03-26T05:17:54.683Z|00025|coverage|INFO|pstream_open
0.0/sec     0.000/sec        0.0000/sec   total: 1
2017-03-26T05:17:54.683Z|00026|coverage|INFO|stream_open
 0.0/sec     0.000/sec        0.0000/sec   total: 1
2017-03-26T05:17:54.683Z|00027|coverage|INFO|util_xalloc
 0.0/sec     0.000/sec        0.0000/sec   total: 7217
2017-03-26T05:17:54.683Z|00028|coverage|INFO|netdev_get_hwaddr
 0.0/sec     0.000/sec        0.0000/sec   total: 2
2017-03-26T05:17:54.684Z|00029|coverage|INFO|netlink_received
0.0/sec     0.000/sec        0.0000/sec   total: 6
2017-03-26T05:17:54.684Z|00030|coverage|INFO|netlink_sent
0.0/sec     0.000/sec        0.0000/sec   total: 1
2017-03-26T05:17:54.684Z|00031|coverage|INFO|86 events never hit
2017-03-26T05:17:54.684Z|00032|poll_loop|INFO|wakeup due to [POLLIN] on fd
11 (<->/usr/local/var/run/openvswitch/db.sock) at lib/stream-fd.c:155 (92%
CPU usage)
2017-03-26T05:17:54.684Z|00033|memory|INFO|5872 kB peak resident set size
after 27.8 seconds
2017-03-26T05:17:54.684Z|00034|bridge|INFO|ovs-vswitchd (Open vSwitch) 2.7.0
2017-03-26T05:27:35.554Z|00035|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports recirculation
2017-03-26T05:27:35.554Z|00036|ofproto_dpif|INFO|netdev at ovs-netdev: MPLS
label stack length probed as 3
2017-03-26T05:27:35.554Z|00037|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports truncate action
2017-03-26T05:27:35.554Z|00038|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports unique flow ids
2017-03-26T05:27:35.554Z|00039|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_state
2017-03-26T05:27:35.554Z|00040|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_zone
2017-03-26T05:27:35.554Z|00041|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_mark
2017-03-26T05:27:35.554Z|00042|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_label
2017-03-26T05:27:35.554Z|00043|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath does not support ct_state_nat
2017-03-26T05:27:35.602Z|00044|bridge|INFO|bridge ovs-ip64-br0: added
interface ovs-ip64-br0 on port 65534
2017-03-26T05:27:35.602Z|00045|bridge|INFO|bridge ovs-ip64-br0: using
datapath ID 0000fe8f2e45c541
2017-03-26T05:27:35.602Z|00046|connmgr|INFO|ovs-ip64-br0: added service
controller "punix:/usr/local/var/run/openvswitch/ovs-ip64-br0.mgmt"
2017-03-26T05:27:36.124Z|00047|memory|INFO|peak resident set size grew 437%
in last 581.4 seconds, from 5872 kB to 31512 kB
2017-03-26T05:27:36.124Z|00048|memory|INFO|handlers:53 ports:1
revalidators:19 rules:5
2017-03-26T05:29:12.882Z|00049|dpif_netdev|INFO|Created 1 pmd threads on
numa node 0
2017-03-26T05:29:12.882Z|00050|dpif_netdev|INFO|Created 1 pmd threads on
numa node 1
2017-03-26T05:34:54.296Z|00001|vlog|INFO|opened log file
/usr/local/var/log/openvswitch/ovs-vswitchd.log
2017-03-26T05:34:54.297Z|00002|ovs_numa|INFO|Discovered 36 CPU cores on
NUMA node 0
2017-03-26T05:34:54.297Z|00003|ovs_numa|INFO|Discovered 36 CPU cores on
NUMA node 1
2017-03-26T05:34:54.297Z|00004|ovs_numa|INFO|Discovered 2 NUMA nodes and 72
CPU cores
2017-03-26T05:34:54.297Z|00005|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connecting...
2017-03-26T05:34:54.298Z|00006|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connected
2017-03-26T05:34:54.301Z|00007|dpdk|INFO|DPDK Enabled - initializing...
2017-03-26T05:34:54.301Z|00008|dpdk|INFO|No vhost-sock-dir provided -
defaulting to /usr/local/var/run/openvswitch
2017-03-26T05:34:54.301Z|00009|dpdk|INFO|EAL ARGS: ovs-vswitchd
--socket-mem 1024,0 -c 0x00000001
2017-03-26T05:35:21.724Z|00010|dpdk|INFO|DPDK Enabled - initialized
2017-03-26T05:35:21.729Z|00011|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports recirculation
2017-03-26T05:35:21.729Z|00012|ofproto_dpif|INFO|netdev at ovs-netdev: MPLS
label stack length probed as 3
2017-03-26T05:35:21.729Z|00013|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports truncate action
2017-03-26T05:35:21.729Z|00014|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports unique flow ids
2017-03-26T05:35:21.729Z|00015|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_state
2017-03-26T05:35:21.729Z|00016|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_zone
2017-03-26T05:35:21.729Z|00017|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_mark
2017-03-26T05:35:21.729Z|00018|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_label
2017-03-26T05:35:21.729Z|00019|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath does not support ct_state_nat
2017-03-26T05:35:21.781Z|00020|dpif_netdev|INFO|Created 1 pmd threads on
numa node 0
2017-03-26T05:35:21.781Z|00021|dpif_netdev|INFO|Created 1 pmd threads on
numa node 1
2017-03-26T05:35:23.041Z|00002|daemon_unix|ERR|fork child died before
signaling startup (killed (Segmentation fault), core dumped)
2017-03-26T05:35:23.041Z|00003|daemon_unix|EMER|could not detach from
foreground session
2017-03-26T05:43:17.614Z|00001|vlog|INFO|opened log file
/usr/local/var/log/openvswitch/ovs-vswitchd.log
2017-03-26T05:43:17.615Z|00002|daemon_unix|DBG|/usr/local/var/run/openvswitch/ovs-vswitchd.pid:
deleted stale pidfile
2017-03-26T05:43:17.615Z|00003|reconnect|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
entering BACKOFF
2017-03-26T05:43:17.616Z|00004|hmap|DBG|lib/ovs-numa.c:117: 6 nodes in
bucket (32 nodes, 16 buckets)
2017-03-26T05:43:17.616Z|00005|ovs_numa|INFO|Discovered 36 CPU cores on
NUMA node 0
2017-03-26T05:43:17.616Z|00006|ovs_numa|INFO|Discovered 36 CPU cores on
NUMA node 1
2017-03-26T05:43:17.616Z|00007|ovs_numa|INFO|Discovered 2 NUMA nodes and 72
CPU cores
2017-03-26T05:43:17.616Z|00008|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connecting...
2017-03-26T05:43:17.616Z|00009|reconnect|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
entering CONNECTING
2017-03-26T05:43:17.616Z|00010|poll_loop|DBG|wakeup due to [POLLOUT] on fd
11 (<->/usr/local/var/run/openvswitch/db.sock) at lib/stream-fd.c:151
2017-03-26T05:43:17.616Z|00011|reconnect|INFO|unix:/usr/local/var/run/openvswitch/db.sock:
connected
2017-03-26T05:43:17.616Z|00012|reconnect|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
entering ACTIVE
2017-03-26T05:43:17.616Z|00013|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
send request, method="get_schema", params=["Open_vSwitch"], id=0
2017-03-26T05:43:17.617Z|00014|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
send request, method="lock", params=["ovs_vswitchd"], id=1
2017-03-26T05:43:17.618Z|00015|poll_loop|DBG|wakeup due to [POLLIN] on fd
11 (<->/usr/local/var/run/openvswitch/db.sock) at lib/stream-fd.c:155
2017-03-26T05:43:17.619Z|00016|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
received reply, result={"cksum":"3374030633
22987","name":"Open_vSwitch","version":"7.14.0","tables":{"Controller":{"columns":{"is_connected":{"ephemeral":true,"type":"boolean"},"connection_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["in-band","out-of-band"]]}}},"local_gateway":{"type":{"min":0,"key":"string"}},"enable_async_messages":{"type":{"min":0,"key":"boolean"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"local_netmask":{"type":{"min":0,"key":"string"}},"controller_burst_limit":{"type":{"min":0,"key":{"minInteger":25,"type":"integer"}}},"controller_rate_limit":{"type":{"min":0,"key":{"minInteger":100,"type":"integer"}}},"local_ip":{"type":{"min":0,"key":"string"}},"role":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["master","other","slave"]]}}},"target":{"type":"string"},"max_backoff":{"type":{"min":0,"key":{"minInteger":1000,"type":"integer"}}},"inactivity_probe":{"type":{"min":0,"key":"integer"}}}},"Bridge":{"indexes":[["name"]],"columns":{"name":{"mutable":false,"type":"string"},"flood_vlans":{"type":{"max":4096,"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}},"auto_attach":{"type":{"min":0,"key":{"type":"uuid","refTable":"AutoAttach"}}},"ports":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Port"}}},"stp_enable":{"type":"boolean"},"rstp_enable":{"type":"boolean"},"fail_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["secure","standalone"]]}}},"rstp_status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"flow_tables":{"type":{"max":"unlimited","min":0,"value":{"type":"uuid","refTable":"Flow_Table"},"key":{"minInteger":0,"type":"integer","maxInteger":254}}},"netflow":{"type":{"min":0,"key":{"type":"uuid","refTable":"NetFlow"}}},"datapath_type":{"type":"string"},"controller":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Controller"}}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ipfix":{"type":{"min":0,"key":{"type":"uuid","refTable":"IPFIX"}}},"datapath_id":{"ephemeral":true,"type":{"min":0,"key":"string"}},"mirrors":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Mirror"}}},"mcast_snooping_enable":{"type":"boolean"},"datapath_version":{"type":"string"},"sflow":{"type":{"min":0,"key":{"type":"uuid","refTable":"sFlow"}}},"protocols":{"type":{"max":"unlimited","min":0,"key":{"type":"string","enum":["set",["OpenFlow10","OpenFlow11","OpenFlow12","OpenFlow13","OpenFlow14","OpenFlow15","OpenFlow16"]]}}}}},"Queue":{"isRoot":true,"columns":{"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"dscp":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":63}}}}},"Open_vSwitch":{"maxRows":1,"isRoot":true,"columns":{"manager_options":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Manager"}}},"bridges":{"type":{"max":"unlimited","min":0,"key":{"type":"uuid","refTable":"Bridge"}}},"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ovs_version":{"type":{"min":0,"key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cur_cfg":{"type":"integer"},"next_cfg":{"type":"integer"},"iface_types":{"type":{"max":"unlimited","min":0,"key":"string"}},"datapath_types":{"type":{"max":"unlimited","min":0,"key":"string"}},"ssl":{"type":{"min":0,"key":{"type":"uuid","refTable":"SSL"}}},"system_version":{"type":{"min":0,"key":"string"}},"db_version":{"type":{"min":0,"key":"string"}},"system_type":{"type":{"min":0,"key":"string"}}}},"NetFlow":{"columns":{"active_timeout":{"type":{"key":{"minInteger":-1,"type":"integer"}}},"add_id_to_interface":{"type":"boolean"},"engine_id":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":255}}},"engine_type":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":255}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"targets":{"type":{"max":"unlimited","key":"string"}}}},"IPFIX":{"columns":{"obs_point_id":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"cache_active_timeout":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4200}}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"sampling":{"type":{"min":0,"key":{"minInteger":1,"type":"integer","maxInteger":4294967295}}},"targets":{"type":{"max":"unlimited","min":0,"key":"string"}},"obs_domain_id":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"cache_max_flows":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}}}},"QoS":{"isRoot":true,"columns":{"queues":{"type":{"max":"unlimited","min":0,"value":{"type":"uuid","refTable":"Queue"},"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"type":{"type":"string"}}},"Port":{"indexes":[["name"]],"columns":{"protected":{"type":"boolean"},"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"name":{"mutable":false,"type":"string"},"bond_downdelay":{"type":"integer"},"mac":{"type":{"min":0,"key":"string"}},"fake_bridge":{"type":"boolean"},"trunks":{"type":{"max":4096,"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}},"tag":{"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}},"rstp_status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"bond_updelay":{"type":"integer"},"bond_active_slave":{"type":{"min":0,"key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"bond_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["active-backup","balance-slb","balance-tcp"]]}}},"qos":{"type":{"min":0,"key":{"type":"uuid","refTable":"QoS"}}},"rstp_statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"vlan_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["access","native-tagged","native-untagged","trunk"]]}}},"interfaces":{"type":{"max":"unlimited","key":{"type":"uuid","refTable":"Interface"}}},"bond_fake_iface":{"type":"boolean"},"lacp":{"type":{"min":0,"key":{"type":"string","enum":["set",["active","off","passive"]]}}}}},"sFlow":{"columns":{"agent":{"type":{"min":0,"key":"string"}},"header":{"type":{"min":0,"key":"integer"}},"polling":{"type":{"min":0,"key":"integer"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"targets":{"type":{"max":"unlimited","key":"string"}},"sampling":{"type":{"min":0,"key":"integer"}}}},"SSL":{"maxRows":1,"columns":{"bootstrap_ca_cert":{"type":"boolean"},"private_key":{"type":"string"},"certificate":{"type":"string"},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ca_cert":{"type":"string"}}},"Flow_Sample_Collector_Set":{"isRoot":true,"indexes":[["id","bridge"]],"columns":{"id":{"type":{"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"ipfix":{"type":{"min":0,"key":{"type":"uuid","refTable":"IPFIX"}}},"bridge":{"type":{"key":{"type":"uuid","refTable":"Bridge"}}}}},"Mirror":{"columns":{"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"select_all":{"type":"boolean"},"name":{"type":"string"},"output_vlan":{"type":{"min":0,"key":{"minInteger":1,"type":"integer","maxInteger":4095}}},"select_dst_port":{"type":{"max":"unlimited","min":0,"key":{"refType":"weak","refTable":"Port","type":"uuid"}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"select_src_port":{"type":{"max":"unlimited","min":0,"key":{"refType":"weak","refTable":"Port","type":"uuid"}}},"snaplen":{"type":{"min":0,"key":{"minInteger":14,"type":"integer","maxInteger":65535}}},"output_port":{"type":{"min":0,"key":{"refType":"weak","refTable":"Port","type":"uuid"}}},"select_vlan":{"type":{"max":4096,"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4095}}}}},"Flow_Table":{"columns":{"name":{"type":{"min":0,"key":"string"}},"prefixes":{"type":{"max":3,"min":0,"key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"groups":{"type":{"max":"unlimited","min":0,"key":"string"}},"flow_limit":{"type":{"min":0,"key":{"minInteger":0,"type":"integer"}}},"overflow_policy":{"type":{"min":0,"key":{"type":"string","enum":["set",["evict","refuse"]]}}}}},"Interface":{"indexes":[["name"]],"columns":{"statistics":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"integer","key":"string"}},"mac":{"type":{"min":0,"key":"string"}},"options":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"bfd_status":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cfm_health":{"ephemeral":true,"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":100}}},"ofport":{"type":{"min":0,"key":"integer"}},"admin_state":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["down","up"]]}}},"error":{"type":{"min":0,"key":"string"}},"cfm_fault_status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"key":"string"}},"lacp_current":{"ephemeral":true,"type":{"min":0,"key":"boolean"}},"mtu":{"ephemeral":true,"type":{"min":0,"key":"integer"}},"ofport_request":{"type":{"min":0,"key":{"minInteger":1,"type":"integer","maxInteger":65279}}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"link_state":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["down","up"]]}}},"cfm_remote_opstate":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["down","up"]]}}},"cfm_fault":{"ephemeral":true,"type":{"min":0,"key":"boolean"}},"link_speed":{"ephemeral":true,"type":{"min":0,"key":"integer"}},"duplex":{"ephemeral":true,"type":{"min":0,"key":{"type":"string","enum":["set",["full","half"]]}}},"ingress_policing_rate":{"type":{"key":{"minInteger":0,"type":"integer"}}},"name":{"mutable":false,"type":"string"},"mtu_request":{"type":{"min":0,"key":{"minInteger":1,"type":"integer"}}},"cfm_flap_count":{"type":{"min":0,"key":"integer"}},"ifindex":{"ephemeral":true,"type":{"min":0,"key":{"minInteger":0,"type":"integer","maxInteger":4294967295}}},"type":{"type":"string"},"mac_in_use":{"ephemeral":true,"type":{"min":0,"key":"string"}},"link_resets":{"ephemeral":true,"type":{"min":0,"key":"integer"}},"lldp":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cfm_remote_mpids":{"ephemeral":true,"type":{"max":"unlimited","min":0,"key":"integer"}},"bfd":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"cfm_mpid":{"type":{"min":0,"key":"integer"}},"ingress_policing_burst":{"type":{"key":{"minInteger":0,"type":"integer"}}}}},"AutoAttach":{"columns":{"mappings":{"type":{"max":"unlimited","min":0,"value":{"minInteger":0,"type":"integer","maxInteger":4095},"key":{"minInteger":0,"type":"integer","maxInteger":16777215}}},"system_name":{"type":"string"},"system_description":{"type":"string"}}},"Manager":{"indexes":[["target"]],"columns":{"connection_mode":{"type":{"min":0,"key":{"type":"string","enum":["set",["in-band","out-of-band"]]}}},"is_connected":{"ephemeral":true,"type":"boolean"},"other_config":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"external_ids":{"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"status":{"ephemeral":true,"type":{"max":"unlimited","min":0,"value":"string","key":"string"}},"target":{"type":"string"},"max_backoff":{"type":{"min":0,"key":{"minInteger":1000,"type":"integer"}}},"inactivity_probe":{"type":{"min":0,"key":"integer"}}}}}},
id=0
2017-03-26T05:43:17.619Z|00017|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
send request, method="monitor_cond",
params=["Open_vSwitch","822a1e21-907f-496c-98e9-fafcde53ac11",{"Controller":{"columns":["connection_mode","controller_burst_limit","controller_rate_limit","enable_async_messages","inactivity_probe","is_connected","local_gateway","local_ip","local_netmask","max_backoff","other_config","role","status","target"]},"Bridge":{"columns":["auto_attach","controller","datapath_id","datapath_type","datapath_version","fail_mode","flood_vlans","flow_tables","ipfix","mcast_snooping_enable","mirrors","name","netflow","other_config","ports","protocols","rstp_enable","rstp_status","sflow","status","stp_enable"]},"Queue":{"columns":["dscp","other_config"]},"IPFIX":{"columns":["cache_active_timeout","cache_max_flows","obs_domain_id","obs_point_id","other_config","sampling","targets"]},"NetFlow":{"columns":["active_timeout","add_id_to_interface","engine_id","engine_type","targets"]},"Open_vSwitch":{"columns":["bridges","cur_cfg","datapath_types","iface_types","manager_options","next_cfg","other_config","ssl","statistics"]},"QoS":{"columns":["other_config","queues","type"]},"Port":{"columns":["bond_active_slave","bond_downdelay","bond_fake_iface","bond_mode","bond_updelay","fake_bridge","interfaces","lacp","mac","name","other_config","protected","qos","rstp_statistics","rstp_status","statistics","status","tag","trunks","vlan_mode"]},"SSL":{"columns":["bootstrap_ca_cert","ca_cert","certificate","private_key"]},"sFlow":{"columns":["agent","header","polling","sampling","targets"]},"Flow_Sample_Collector_Set":{"columns":["bridge","id","ipfix"]},"Flow_Table":{"columns":["external_ids","flow_limit","groups","name","overflow_policy","prefixes"]},"Mirror":{"columns":["name","output_port","output_vlan","select_all","select_dst_port","select_src_port","select_vlan","snaplen","statistics"]},"Interface":{"columns":["admin_state","bfd","bfd_status","cfm_fault","cfm_fault_status","cfm_flap_count","cfm_health","cfm_mpid","cfm_remote_mpids","cfm_remote_opstate","duplex","error","ifindex","ingress_policing_burst","ingress_policing_rate","lacp_current","link_resets","link_speed","link_state","lldp","mac","mac_in_use","mtu","mtu_request","name","ofport","ofport_request","options","other_config","statistics","status","type"]},"AutoAttach":{"columns":["mappings","system_description","system_name"]},"Manager":{"columns":["connection_mode","other_config","target"]}}],
id=2
2017-03-26T05:43:17.620Z|00018|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
received reply, result={"locked":true}, id=1
2017-03-26T05:43:17.620Z|00019|poll_loop|DBG|wakeup due to [POLLIN] on fd
11 (<->/usr/local/var/run/openvswitch/db.sock) at lib/stream-fd.c:155
2017-03-26T05:43:17.620Z|00020|jsonrpc|DBG|unix:/usr/local/var/run/openvswitch/db.sock:
received reply,
result={"Interface":{"e1cdb7cb-ce8c-4295-b1ae-5740b2544524":{"initial":{"mac_in_use":"fe:8f:2e:45:c5:41","link_resets":0,"name":"ovs-ip64-br0","statistics":["map",[["collisions",0],["rx_bytes",0],["rx_crc_err",0],["rx_dropped",0],["rx_errors",0],["rx_frame_err",0],["rx_over_err",0],["rx_packets",0],["tx_bytes",0],["tx_dropped",0],["tx_errors",0],["tx_packets",0]]],"mtu":1500,"ifindex":18,"status":["map",[["driver_name","tun"],["driver_version","1.6"],["firmware_version",""]]],"link_state":"down","type":"internal","link_speed":10000000,"ofport":65534,"duplex":"full","admin_state":"down"}},"02438858-c153-41d2-8e03-02a8fb07c64f":{"initial":{"name":"dpdk-p0","options":["map",[["dpdk-devargs","0000:82:00.0"]]],"type":"dpdk"}}},"Port":{"45465e63-9968-4486-845c-03b0acbd036b":{"initial":{"name":"dpdk-p0","interfaces":["uuid","02438858-c153-41d2-8e03-02a8fb07c64f"]}},"78d29fd3-ef96-4f22-89a8-e290efbc9b86":{"initial":{"name":"ovs-ip64-br0","interfaces":["uuid","e1cdb7cb-ce8c-4295-b1ae-5740b2544524"]}}},"Bridge":{"452e8ffc-fbd3-41c5-85ba-42a5eb921958":{"initial":{"name":"ovs-ip64-br0","ports":["set",[["uuid","45465e63-9968-4486-845c-03b0acbd036b"],["uuid","78d29fd3-ef96-4f22-89a8-e290efbc9b86"]]],"datapath_type":"netdev","datapath_id":"0000fe8f2e45c541","datapath_version":"<built-in>"}}},"Open_vSwitch":{"ef1929d5-2698-4e92-9599-e2a29b010d4d":{"initial":{"bridges":["uuid","452e8ffc-fbd3-41c5-85ba-42a5eb921958"],"iface_types":["set",["dpdk","dpdkr","dpdkvhostuser","dpdkvhostuserclient","geneve","gre","internal","lisp","patch","stt","system","tap","vxlan"]],"datapath_types":["set",["netdev","system"]],"other_config":["map",[["dpdk-init","true"]]],"cur_cfg":1,"next_cfg":2}}}},
id=2
2017-03-26T05:43:17.621Z|00021|dpdk|INFO|DPDK Enabled - initializing...
2017-03-26T05:43:17.621Z|00022|dpdk|INFO|No vhost-sock-dir provided -
defaulting to /usr/local/var/run/openvswitch
2017-03-26T05:43:17.621Z|00023|dpdk|INFO|EAL ARGS: ovs-vswitchd
--socket-mem 1024,0 -c 0x00000001
2017-03-26T05:43:45.569Z|00024|dpdk|INFO|DPDK Enabled - initialized
2017-03-26T05:43:45.570Z|00025|hmap|DBG|lib/shash.c:112: 7 nodes in bucket
(64 nodes, 32 buckets)
2017-03-26T05:43:45.570Z|00001|poll_loop(urcu3)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.570Z|00026|netlink_socket|DBG|nl_sock_send__ (Success):
nl(len:17, type=26(family-defined), flags=305[REQUEST][ACK][DUMP], seq=1,
pid=2618663578
2017-03-26T05:43:45.570Z|00027|netlink_socket|DBG|nl_sock_recv__ (Success):
nl(len:52, type=24(family-defined), flags=2[MULTI], seq=1, pid=2618663578
2017-03-26T05:43:45.571Z|00028|netlink_socket|DBG|nl_sock_recv__ (Success):
nl(len:116, type=24(family-defined), flags=2[MULTI], seq=1, pid=2618663578
2017-03-26T05:43:45.571Z|00029|netlink_socket|DBG|nl_sock_recv__ (Success):
nl(len:20, type=3(done), flags=2[MULTI], seq=1, pid=2618663578 done(0)
2017-03-26T05:43:45.571Z|00001|conntrack(ct_clean4)|DBG|conntrack cleanup 0
entries in 0 msec
2017-03-26T05:43:45.572Z|00002|poll_loop(ct_clean4)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.572Z|00003|conntrack(ct_clean4)|DBG|conntrack cleanup 0
entries in 0 msec
2017-03-26T05:43:45.574Z|00030|dpif|DBG|netdev at ovs-netdev: flow_flush
success
2017-03-26T05:43:45.574Z|00031|dpif|DBG|netdev at ovs-netdev: port_dump_start
success
2017-03-26T05:43:45.574Z|00032|dpif|DBG|netdev at ovs-netdev: port_dump_next
success
2017-03-26T05:43:45.575Z|00033|dpif|DBG|netdev at ovs-netdev: dumped all ports
2017-03-26T05:43:45.575Z|00034|dpif_netdev|DBG|Creating dpcls
0x55f67bde9360 for in_port 0
2017-03-26T05:43:45.575Z|00035|dpif_netdev|DBG|Creating 1. subtable
0x55f67bde9530 for in_port 0
2017-03-26T05:43:45.575Z|00036|dpif_netdev|DBG|flow_add:
ufid:e1027d2d-7dcc-41d0-8959-83b811ec3fd1
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0x1),dp_hash(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45.575Z|00037|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),recirc_id(0x1),dp_hash(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.575Z|00038|dpif_netdev|DBG|Destroying subtable
0x55f67bde9530 for in_port 0
2017-03-26T05:43:45.575Z|00039|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),recirc_id(0x1),dp_hash(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45.575Z|00040|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports recirculation
2017-03-26T05:43:45.575Z|00041|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdea250 for in_port 0
2017-03-26T05:43:45.575Z|00042|dpif_netdev|DBG|flow_add:
ufid:9721ff36-8638-4a41-8c56-68881785af6f
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=1),
actions:drop
2017-03-26T05:43:45.575Z|00043|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=1),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.575Z|00044|dpif_netdev|DBG|Destroying subtable
0x55f67bdea250 for in_port 0
2017-03-26T05:43:45.575Z|00045|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=1)
2017-03-26T05:43:45.575Z|00046|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdeabf0 for in_port 0
2017-03-26T05:43:45.575Z|00047|dpif_netdev|DBG|flow_add:
ufid:02c0d9f7-7ad0-4cc9-8706-89f093c03915
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
actions:drop
2017-03-26T05:43:45.575Z|00048|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.575Z|00049|dpif_netdev|DBG|Destroying subtable
0x55f67bdeabf0 for in_port 0
2017-03-26T05:43:45.575Z|00050|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1)
2017-03-26T05:43:45.575Z|00051|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdeb6a0 for in_port 0
2017-03-26T05:43:45.575Z|00002|poll_loop(urcu3)|DBG|wakeup due to [POLLIN]
on fd 45 (FIFO pipe:[1313046]) at lib/ovs-rcu.c:310
2017-03-26T05:43:45.575Z|00052|dpif_netdev|DBG|flow_add:
ufid:9398c63e-412a-4b48-9c09-cdd19524127e
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
actions:drop
2017-03-26T05:43:45.575Z|00053|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.575Z|00054|dpif_netdev|DBG|Destroying subtable
0x55f67bdeb6a0 for in_port 0
2017-03-26T05:43:45.575Z|00055|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x8847),mpls(label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=0,label=0,tc=0,ttl=0,bos=1)
2017-03-26T05:43:45.576Z|00056|ofproto_dpif|INFO|netdev at ovs-netdev: MPLS
label stack length probed as 3
2017-03-26T05:43:45.576Z|00057|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports truncate action
2017-03-26T05:43:45.576Z|00058|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdec030 for in_port 0
2017-03-26T05:43:45.576Z|00059|dpif_netdev|DBG|flow_add:
ufid:604b145b-df63-4a74-9af0-33e23db7c5cf
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234),
actions:drop
2017-03-26T05:43:45.576Z|00060|dpif|DBG|netdev at ovs-netdev: flow_get
ufid:604b145b-df63-4a74-9af0-33e23db7c5cf
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.576Z|00061|dpif_netdev|DBG|Destroying subtable
0x55f67bdec030 for in_port 0
2017-03-26T05:43:45.576Z|00062|dpif|DBG|netdev at ovs-netdev: flow_del
ufid:604b145b-df63-4a74-9af0-33e23db7c5cf
skb_priority(0),skb_mark(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234)
2017-03-26T05:43:45.576Z|00063|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports unique flow ids
2017-03-26T05:43:45.576Z|00064|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdec9b0 for in_port 0
2017-03-26T05:43:45.576Z|00065|dpif_netdev|DBG|flow_add:
ufid:ae78bdb5-65ca-44c9-9516-de37a873d584
skb_priority(0),skb_mark(0),ct_state(+new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45.576Z|00066|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_state(0x1/0xff),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.576Z|00067|dpif_netdev|DBG|Destroying subtable
0x55f67bdec9b0 for in_port 0
2017-03-26T05:43:45.576Z|00068|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_state(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45.576Z|00069|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_state
2017-03-26T05:43:45.576Z|00070|dpif_netdev|DBG|Creating 1. subtable
0x55f67bded450 for in_port 0
2017-03-26T05:43:45.576Z|00071|dpif_netdev|DBG|flow_add:
ufid:a4487d75-0146-4eb2-ad0e-9de01853bab1
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0x1),ct_mark(0),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45.576Z|00072|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_zone(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.576Z|00073|dpif_netdev|DBG|Destroying subtable
0x55f67bded450 for in_port 0
2017-03-26T05:43:45.576Z|00074|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_zone(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45.576Z|00075|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_zone
2017-03-26T05:43:45.576Z|00076|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdede50 for in_port 0
2017-03-26T05:43:45.576Z|00077|dpif_netdev|DBG|flow_add:
ufid:b82a810f-bc0e-4d81-ab17-d35b5ada3b48
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0x1),ct_label(0),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45.576Z|00078|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_mark(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.576Z|00079|dpif_netdev|DBG|Destroying subtable
0x55f67bdede50 for in_port 0
2017-03-26T05:43:45.576Z|00080|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_mark(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45.576Z|00081|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_mark
2017-03-26T05:43:45.576Z|00082|dpif_netdev|DBG|Creating 1. subtable
0x55f67bdee850 for in_port 0
2017-03-26T05:43:45.576Z|00083|dpif_netdev|DBG|flow_add:
ufid:9edc61b5-86f9-4e32-81d7-083196e2713a
skb_priority(0),skb_mark(0),ct_state(-new-est-rel-rpl-inv-trk-snat-dnat),ct_zone(0),ct_mark(0),ct_label(0x1),recirc_id(0),dp_hash(0),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
actions:drop
2017-03-26T05:43:45.576Z|00084|dpif|DBG|netdev at ovs-netdev: flow_get
skb_priority(0),skb_mark(0),ct_label(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0/0xffff),
packets:0, bytes:0, used:never, actions:drop
2017-03-26T05:43:45.577Z|00085|dpif_netdev|DBG|Destroying subtable
0x55f67bdee850 for in_port 0
2017-03-26T05:43:45.577Z|00086|dpif|DBG|netdev at ovs-netdev: flow_del
skb_priority(0),skb_mark(0),ct_label(0x1),in_port(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00)
2017-03-26T05:43:45.577Z|00087|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath supports ct_label
2017-03-26T05:43:45.577Z|00088|ofproto_dpif|INFO|netdev at ovs-netdev:
Datapath does not support ct_state_nat
2017-03-26T05:43:45.577Z|00003|poll_loop(urcu3)|DBG|wakeup due to [POLLIN]
on fd 45 (FIFO pipe:[1313046]) at lib/ovs-rcu.c:230
2017-03-26T05:43:45.578Z|00001|poll_loop(handler5)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.578Z|00001|poll_loop(handler6)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.579Z|00001|poll_loop(handler7)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.580Z|00001|poll_loop(handler8)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.580Z|00001|poll_loop(handler9)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.581Z|00001|poll_loop(handler10)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.582Z|00001|poll_loop(handler11)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.582Z|00001|poll_loop(handler12)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.583Z|00001|poll_loop(handler15)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.585Z|00001|poll_loop(handler14)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.585Z|00001|poll_loop(handler13)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.585Z|00001|poll_loop(handler16)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.585Z|00001|poll_loop(handler17)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler18)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler19)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler20)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler21)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler22)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler23)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler24)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.586Z|00001|poll_loop(handler25)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.587Z|00001|poll_loop(handler26)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.587Z|00001|poll_loop(handler27)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.588Z|00001|poll_loop(handler28)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.588Z|00001|poll_loop(handler29)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.588Z|00001|poll_loop(handler30)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.588Z|00001|poll_loop(handler31)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.588Z|00001|poll_loop(handler32)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.588Z|00001|poll_loop(handler34)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.589Z|00001|poll_loop(handler36)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.589Z|00001|poll_loop(handler33)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.589Z|00001|poll_loop(handler35)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.589Z|00001|poll_loop(handler37)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.590Z|00001|poll_loop(handler38)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.590Z|00001|poll_loop(handler39)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.590Z|00001|poll_loop(handler40)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.590Z|00001|poll_loop(handler41)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.590Z|00001|poll_loop(handler42)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.591Z|00001|poll_loop(handler44)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.591Z|00001|poll_loop(handler45)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.591Z|00001|poll_loop(handler43)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler50)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler46)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler47)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler48)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler49)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler51)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler53)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler52)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler54)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.592Z|00001|poll_loop(handler55)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.593Z|00001|poll_loop(handler57)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.593Z|00001|poll_loop(handler56)|DBG|wakeup due to 0-ms
timeout
2017-03-26T05:43:45.594Z|00001|poll_loop(revalidator59)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.594Z|00001|poll_loop(revalidator61)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.620Z|00001|dpif(revalidator58)|DBG|netdev at ovs-netdev:
get_stats success
2017-03-26T05:43:45.620Z|00001|poll_loop(revalidator60)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.620Z|00001|poll_loop(revalidator62)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.620Z|00002|poll_loop(revalidator58)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.620Z|00001|poll_loop(revalidator67)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.620Z|00001|poll_loop(revalidator69)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator72)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator65)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator74)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator66)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator71)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00089|dpif_netdev|DBG|ovs-netdev: 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(0),eth(src=00:00:00:00:00:00,dst=00:00:00:00:00:00),eth_type(0x1234)
vlan_tci=0x0000,dl_src=00:00:00:00:00:00,dl_dst=00:00:00:00:00:00,dl_type=0x1234
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator68)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator63)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator73)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator70)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00001|dpif(revalidator64)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|dpif(revalidator71)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator76)|DBG|wakeup due to
0-ms timeout at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator60)|DBG|wakeup due to
[POLLIN] on fd 63 (FIFO pipe:[1298230]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator72)|DBG|wakeup due to
[POLLIN] on fd 75 (FIFO pipe:[1291015]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator64)|DBG|wakeup due to
0-ms timeout
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator66)|DBG|wakeup due to
[POLLIN] on fd 85 (FIFO pipe:[1325360]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|dpif(revalidator63)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|dpif(revalidator65)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator69)|DBG|wakeup due to
[POLLIN] on fd 73 (FIFO pipe:[1307398]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|dpif(revalidator70)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator59)|DBG|wakeup due to
[POLLIN] on fd 59 (FIFO pipe:[1288174]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00003|dpif(revalidator60)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00003|dpif(revalidator72)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|dpif(revalidator76)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00003|dpif(revalidator66)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|dpif(revalidator68)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00003|dpif(revalidator69)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|dpif(revalidator73)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00003|dpif(revalidator59)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00003|poll_loop(revalidator58)|DBG|wakeup due to
[POLLIN] on fd 69 (FIFO pipe:[1336468]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00001|poll_loop(revalidator75)|DBG|wakeup due to
[POLLIN] on fd 83 (FIFO pipe:[1288179]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|dpif(revalidator74)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator67)|DBG|wakeup due to
[POLLIN] on fd 71 (FIFO pipe:[1345686]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator61)|DBG|wakeup due to
[POLLIN] on fd 61 (FIFO pipe:[1338436]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00002|dpif(revalidator75)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00002|poll_loop(revalidator62)|DBG|wakeup due to
[POLLIN] on fd 65 (FIFO pipe:[1288178]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.621Z|00003|dpif(revalidator67)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00004|dpif(revalidator58)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00003|dpif(revalidator62)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.621Z|00003|dpif(revalidator61)|DBG|netdev at ovs-netdev:
dumped all flows
2017-03-26T05:43:45.622Z|00004|poll_loop(revalidator67)|DBG|wakeup due to
[POLLIN] on fd 71 (FIFO pipe:[1345686]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator73)|DBG|wakeup due to
[POLLIN] on fd 87 (FIFO pipe:[1304278]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00004|poll_loop(revalidator62)|DBG|wakeup due to
[POLLIN] on fd 65 (FIFO pipe:[1288178]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00005|poll_loop(revalidator58)|DBG|wakeup due to
[POLLIN] on fd 69 (FIFO pipe:[1336468]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00004|poll_loop(revalidator59)|DBG|wakeup due to
[POLLIN] on fd 59 (FIFO pipe:[1288174]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator70)|DBG|wakeup due to
[POLLIN] on fd 91 (FIFO pipe:[1345052]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator75)|DBG|wakeup due to
[POLLIN] on fd 83 (FIFO pipe:[1288179]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00004|poll_loop(revalidator69)|DBG|wakeup due to
[POLLIN] on fd 73 (FIFO pipe:[1307398]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00004|poll_loop(revalidator66)|DBG|wakeup due to
[POLLIN] on fd 85 (FIFO pipe:[1325360]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator68)|DBG|wakeup due to
[POLLIN] on fd 89 (FIFO pipe:[1326479]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator63)|DBG|wakeup due to
[POLLIN] on fd 67 (FIFO pipe:[1307397]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator65)|DBG|wakeup due to
[POLLIN] on fd 79 (FIFO pipe:[1336469]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00004|poll_loop(revalidator72)|DBG|wakeup due to
[POLLIN] on fd 75 (FIFO pipe:[1291015]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator74)|DBG|wakeup due to
[POLLIN] on fd 77 (FIFO pipe:[1338437]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator71)|DBG|wakeup due to
[POLLIN] on fd 81 (FIFO pipe:[1319252]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00004|poll_loop(revalidator60)|DBG|wakeup due to
[POLLIN] on fd 63 (FIFO pipe:[1298230]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator76)|DBG|wakeup due to
[POLLIN] on fd 95 (FIFO pipe:[1297250]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00003|poll_loop(revalidator64)|DBG|wakeup due to
[POLLIN] on fd 93 (FIFO pipe:[1336470]) at lib/ovs-thread.c:312
2017-03-26T05:43:45.622Z|00090|dpif_netdev|INFO|Created 1 pmd threads on
numa node 0
2017-03-26T05:43:45.622Z|00091|dpif_netdev|INFO|Created 1 pmd threads on
numa node 1
2017-03-26T05:43:46.869Z|00002|daemon_unix|ERR|fork child died before
signaling startup (killed (Segmentation fault), core dumped)
2017-03-26T05:43:46.869Z|00003|daemon_unix|EMER|could not detach from
foreground session

# *cat /proc/cmdline*
BOOT_IMAGE=/vmlinuz-4.8.0-39-generic root=/dev/mapper/intelsdn--vg-root ro
intel_iommu=on iommu=pt quiet default_hugepagesz=1G hugepagesz=1G
hugepages=4

Ubuntu 16.10 is used.




On Fri, Mar 24, 2017 at 10:08 AM, Guru Shetty <guru at ovn.org> wrote:

>
>
> On 23 March 2017 at 22:36, Shivaram Mysore <shivaram.mysore at gmail.com>
> wrote:
>
>> One more data point:
>>
>> I *CNTRL-C* the command ovs-vsctl add-port
>>
>> ^C2017-03-24T05:25:30Z|00002|fatal_signal|WARN|terminating with signal 2
>> (Interrupt)
>>
>>
>> # *ovs-vsctl show*
>> 0a0e3abd-c1de-40fd-bc14-9a8edb89982d
>>     Bridge "ovs-br0"
>>         Port "ovs-br0"
>>             Interface "ovs-br0"
>>                 type: internal
>>         Port "dpdk-p0"
>>             Interface "dpdk-p0"
>>                 type: dpdk
>>                 options: {dpdk-devargs="0000:82:00.0"}
>>
>> Looks like port is created.
>>
>> I see add-port and del-port is very very slow - basically hangs and I
>> have to CNTRL-C.  Nothing in the logs.  I am not sure what is causing
>> this.  I never had any issues without DPDK.
>>
>
> In non-DPDK OVS, it is usually a signal that ovs-vswitchd is not running.
>
>
>>
>> Thanks
>>
>>
>> On Thu, Mar 23, 2017 at 10:26 PM, Shivaram Mysore <
>> shivaram.mysore at gmail.com> wrote:
>>
>>> Hello,
>>>
>>> I just built OVS 2.7 with DPDK 17.02 and installed the same on Ubuntu
>>> 16.10.  Adding a DPDK port to the OVS bridge hangs.  *Any thoughts?*
>>> (Note: I have overridden the openvswitch.ko and other *.ko with the built
>>> ones using depmod config)
>>>
>>> # *uname -r*
>>> 4.8.0-39-generic
>>>
>>> # */usr/local/src/dpdk-17.02/usertools/dpdk-devbind.py --status*
>>>
>>> Network devices using DPDK-compatible driver
>>> ============================================
>>> 0000:82:00.0 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>> 0000:82:00.1 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>> 0000:82:00.2 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>> 0000:82:00.3 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>> 0000:83:00.0 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>> 0000:83:00.1 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>> 0000:83:00.2 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>> 0000:83:00.3 'I350 Gigabit Network Connection' drv=igb_uio unused=igb
>>>
>>>
>>> # *ovs-vsctl add-br ovs-br0 -- set bridge ovs-br0 datapath_type=netdev*
>>>
>>> # *ovs-vsctl show*
>>> 0a0e3abd-c1de-40fd-bc14-9a8edb89982d
>>>     Bridge "ovs-br0"
>>>         Port "ovs-br0"
>>>             Interface "ovs-br0"
>>>                 type: internal
>>>
>>> # *ovs-vsctl add-port ovs-br0 dpdk-p0 -- set Interface dpdk-p0
>>> type=dpdk options:dpdk-devargs=0000:82:00.0*
>>> *----> hangs*
>>>
>>> # *tail -f /usr/local/var/log/openvswitch/ovs-vswitchd.log*
>>>
>>> 2017-03-24T05:11:45.518Z|00065|dpif_netdev|INFO|Created 1 pmd threads
>>> on numa node 0
>>> 2017-03-24T05:11:45.518Z|00066|dpif_netdev|INFO|Created 1 pmd threads
>>> on numa node 1
>>>
>>
>>
>> _______________________________________________
>> discuss mailing list
>> discuss at openvswitch.org
>> https://mail.openvswitch.org/mailman/listinfo/ovs-discuss
>>
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mail.openvswitch.org/pipermail/ovs-discuss/attachments/20170325/a1a98e19/attachment-0001.html>


More information about the discuss mailing list