[Openstack-operators] RE : RE : Can't launch docker instance, Unexpected vif_type=binding_failed.

Asmaa Chebba achebba at CDTA.DZ
Wed Jul 29 14:25:04 UTC 2015


I could finally launch the instance. The error was due to the use of the external network (flat). however, when using gre network, the spawning is done successfully.
Thanks for your help.
________________________________
De : Asmaa Chebba
Date d'envoi : mercredi 29 juillet 2015 10:36
À : Kevin Benton
Cc: Assaf Muller; OpenStack Operators
Objet : RE : RE : [Openstack-operators] Can't launch docker instance, Unexpected vif_type=binding_failed.

1. ml2_conf.ini in controller:
[ml2]
type_drivers = flat,gre
tenant_network_types = gre
mechanism_drivers = openvswitch
[ml2_type_gre]
tunnel_id_ranges = 1:1000
[securitygroup]
enable_security_group = True
enable_ipset = True
firewall_driver = neutron.agent.linux.iptables_firewall.OVSHybridIptablesFirewallDriver

2. ml2_conf.ini in compute2:
[ml2]
type_drivers = flat,gre
tenant_network_types = gre
mechanism_drivers = openvswitch
[ml2_type_gre]
tunnel_id_ranges = 1:1000
[securitygroup]
enable_security_group = True
enable_ipset = True
firewall_driver = neutron.agent.linux.iptables_firewall.OVSHybridIptablesFirewallDriver
[ovs]
local_ip = 192.168.2.5
enable_tunneling = True
[agent]
tunnel_types = gre

3. nova-compute.log in compute2:
2015-07-29 11:13:50.857 5166 WARNING novadocker.virt.docker.driver [-] [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4] Cannot setup network: Unexpected vif_type=binding_failed
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4] Traceback (most recent call last):
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]   File "/usr/local/lib/python2.7/dist-packages/novadocker/virt/docker/driver.py", line 367, in _start_container
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]     self.plug_vifs(instance, network_info)
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]   File "/usr/local/lib/python2.7/dist-packages/novadocker/virt/docker/driver.py", line 187, in plug_vifs
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]     self.vif_driver.plug(instance, vif)
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]   File "/usr/local/lib/python2.7/dist-packages/novadocker/virt/docker/vifs.py", line 63, in plug
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]     _("Unexpected vif_type=%s") % vif_type)
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4] NovaException: Unexpected vif_type=binding_failed
2015-07-29 11:13:50.857 5166 TRACE novadocker.virt.docker.driver [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]
2015-07-29 11:13:51.050 5166 ERROR nova.compute.manager [-] [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4] Instance failed to spawn
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4] Traceback (most recent call last):
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]   File "/usr/lib/python2.7/dist-packages/nova/compute/manager.py", line 2267, in _build_resources
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]     yield resources
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]   File "/usr/lib/python2.7/dist-packages/nova/compute/manager.py", line 2137, in _build_and_run_instance
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]     block_device_info=block_device_info)
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]   File "/usr/local/lib/python2.7/dist-packages/novadocker/virt/docker/driver.py", line 404, in spawn
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]     self._start_container(container_id, instance, network_info)
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]   File "/usr/local/lib/python2.7/dist-packages/novadocker/virt/docker/driver.py", line 376, in _start_container
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]     instance_id=instance['name'])
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4] InstanceDeployFailure: Cannot setup network: Unexpected vif_type=binding_failed
2015-07-29 11:13:51.050 5166 TRACE nova.compute.manager [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4]
2015-07-29 11:13:51.051 5166 AUDIT nova.compute.manager [req-156ad821-5880-4560-83f1-e9a2efb4b4c6 None] [instance: 52c3d98f-f99c-4d42-969b-16308cbf9db4] Terminating instance
2015-07-29 11:13:51.186 5166 INFO nova.scheduler.client.report [-] Compute_service record updated for ('compute2', 'compute2')

4. the log file for neutron server:

2015-07-29 11:13:45.726 2282 INFO neutron.wsgi [req-67398b60-ab27-49aa-8d9d-24c750252d7c None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/quotas/50d58b42ce7043ac8f37d564fe1fb11c.json HTTP/1.1" 200 324 0.011199
2015-07-29 11:13:45.727 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44772)
2015-07-29 11:13:45.733 2282 INFO neutron.wsgi [req-a267604f-ece6-49e6-8a45-ef6927ec332b None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/floatingips.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 486 0.005865
2015-07-29 11:13:45.734 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44773)
2015-07-29 11:13:45.754 2282 INFO neutron.wsgi [req-ed3a8c6a-dad4-4ecf-87d0-39fc1fec36a0 None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 202 0.019193
2015-07-29 11:13:45.822 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44778)
2015-07-29 11:13:45.839 2282 INFO neutron.wsgi [req-7082cb8b-ae14-42bc-a89d-ae01b4baca1e None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/security-groups.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 1726 0.016275
2015-07-29 11:13:45.839 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44779)
2015-07-29 11:13:45.854 2282 INFO neutron.wsgi [req-c827316c-c221-4584-adb2-8e72518cab76 None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/networks.json?shared=False&tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 567 0.014127
2015-07-29 11:13:45.855 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44780)
2015-07-29 11:13:45.870 2282 INFO neutron.wsgi [req-6cb9959c-c6ac-4292-8fb1-233e5a73f716 None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/subnets.json HTTP/1.1" 200 1057 0.013845
2015-07-29 11:13:45.871 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44781)
2015-07-29 11:13:45.883 2282 INFO neutron.wsgi [req-b23f256c-c0da-4f33-9584-5af6629498d7 None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/networks.json?shared=True HTTP/1.1" 200 205 0.010787
2015-07-29 11:13:45.883 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44782)
2015-07-29 11:13:45.905 2282 INFO neutron.wsgi [req-f7c7b372-68ee-41cb-8399-37ae3bc05cce None] 192.168.1.2 - - [29/Jul/2015 11:13:45] "GET /v2.0/subnets.json HTTP/1.1" 200 1057 0.021410
2015-07-29 11:13:46.008 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44786)
2015-07-29 11:13:46.033 2282 INFO neutron.wsgi [req-582f1c4f-c444-48cd-80a2-1f0f4ba4596c None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 567 0.023761
2015-07-29 11:13:46.034 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44787)
2015-07-29 11:13:46.056 2282 INFO neutron.wsgi [req-2f1431be-5471-4885-bbb8-d365915700e6 None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 202 0.021720
2015-07-29 11:13:46.057 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44788)
2015-07-29 11:13:46.066 2282 INFO neutron.wsgi [req-852b259c-a4f9-4fd0-ab4f-69675ab05c91 None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/quotas/50d58b42ce7043ac8f37d564fe1fb11c.json HTTP/1.1" 200 324 0.008286
2015-07-29 11:13:46.501 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44792)
2015-07-29 11:13:46.568 2282 INFO neutron.wsgi [req-8fc74135-478c-4b8f-b127-090f045243f2 None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/ports.json?device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 202 0.062276
2015-07-29 11:13:46.569 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44793)
2015-07-29 11:13:46.623 2282 INFO neutron.wsgi [req-74a5b5e9-2987-484a-9446-4c3068245fce None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/ports.json?device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 202 0.049072
2015-07-29 11:13:46.629 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44794)
2015-07-29 11:13:46.661 2282 INFO neutron.wsgi [req-cc535e01-8235-43d8-a006-8899a2e96898 None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/floatingips.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 486 0.030780
2015-07-29 11:13:46.662 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44795)
2015-07-29 11:13:46.726 2282 INFO neutron.wsgi [req-f669276f-7903-4ed9-932a-80bdd4dcc92a None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 202 0.062313
2015-07-29 11:13:46.728 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44796)
2015-07-29 11:13:46.772 2282 INFO neutron.wsgi [req-ffd06ea1-2948-4262-9d7f-ffacea08c9fd None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/networks.json HTTP/1.1" 200 922 0.042526
2015-07-29 11:13:46.776 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44797)
2015-07-29 11:13:46.827 2282 INFO neutron.wsgi [req-76b565f1-1408-444c-9e01-249681d0db94 None] 192.168.1.2 - - [29/Jul/2015 11:13:46] "GET /v2.0/subnets.json HTTP/1.1" 200 1057 0.045493
2015-07-29 11:13:47.025 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44802)
2015-07-29 11:13:47.031 2282 INFO neutron.wsgi [req-60c28771-ea8b-41fc-8d7e-e0a2f6b4fa8c None] 192.168.1.2 - - [29/Jul/2015 11:13:47] "GET /v2.0/extensions.json HTTP/1.1" 200 4302 0.004599
2015-07-29 11:13:48.183 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44810)
2015-07-29 11:13:48.247 2282 INFO neutron.wsgi [req-e0ee1b8b-5dd5-4b7a-8dd8-bcdccb2cd946 None] 192.168.1.2 - - [29/Jul/2015 11:13:48] "GET /v2.0/ports.json?device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 202 0.059973
2015-07-29 11:13:48.777 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44814)
2015-07-29 11:13:48.801 2282 INFO neutron.wsgi [req-7dab3b7a-b876-4305-a7df-f3819628c780 None] 192.168.1.2 - - [29/Jul/2015 11:13:48] "GET /v2.0/extensions.json HTTP/1.1" 200 4302 0.023134
2015-07-29 11:13:48.883 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52168)
2015-07-29 11:13:48.916 2282 INFO neutron.wsgi [req-d8548754-2e87-469d-8a14-d0f6732f08ef None] 192.168.1.5 - - [29/Jul/2015 11:13:48] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.030698
2015-07-29 11:13:49.012 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52169)
2015-07-29 11:13:49.032 2282 INFO neutron.wsgi [req-95b856ab-583a-47c1-8678-ae7cc6a2eb44 None] 192.168.1.5 - - [29/Jul/2015 11:13:49] "GET /v2.0/security-groups.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c HTTP/1.1" 200 1750 0.018625
2015-07-29 11:13:49.034 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52170)
2015-07-29 11:13:49.044 2282 INFO neutron.wsgi [req-07c3cd68-ccf6-4798-a4bb-72c0bc839374 None] 192.168.1.5 - - [29/Jul/2015 11:13:49] "GET /v2.0/extensions.json HTTP/1.1" 200 4326 0.008670
2015-07-29 11:13:49.695 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52172)
2015-07-29 11:13:49.718 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:13:49.874 2282 INFO neutron.quota [req-09e4579c-2e95-4bd9-a580-d26b256e977f None] Loaded quota_driver: <neutron.db.quota_db.DbQuotaDriver object at 0x7f2018e99cd0>.
2015-07-29 11:13:50.000 2282 WARNING neutron.plugins.ml2.managers [req-09e4579c-2e95-4bd9-a580-d26b256e977f None] Failed to bind port 6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 on host compute2
2015-07-29 11:13:50.056 2282 INFO neutron.wsgi [req-09e4579c-2e95-4bd9-a580-d26b256e977f None] 192.168.1.5 - - [29/Jul/2015 11:13:50] "POST /v2.0/ports.json HTTP/1.1" 201 916 0.360514
2015-07-29 11:13:50.061 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52173)
2015-07-29 11:13:50.082 2282 INFO neutron.wsgi [req-c8e5a4f2-639b-45b9-a8b3-2fe6ec0cb7e6 None] 192.168.1.5 - - [29/Jul/2015 11:13:50] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.019967
2015-07-29 11:13:50.085 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52174)
2015-07-29 11:13:50.089 2282 INFO neutron.wsgi [req-e042a3b6-9091-4e38-ad13-6927e9918813 None] 192.168.1.5 - - [29/Jul/2015 11:13:50] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.003693
2015-07-29 11:13:50.092 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52175)
2015-07-29 11:13:50.103 2282 INFO neutron.wsgi [req-d1a9dadb-58e9-40f8-b3f3-bcabb2b95988 None] 192.168.1.5 - - [29/Jul/2015 11:13:50] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.008960
2015-07-29 11:13:50.106 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52176)
2015-07-29 11:13:50.121 2282 INFO neutron.wsgi [req-e30bd2a2-df50-4338-b636-ee86c7e66ef6 None] 192.168.1.5 - - [29/Jul/2015 11:13:50] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.014181
2015-07-29 11:13:52.239 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44818)
2015-07-29 11:13:52.262 2282 INFO neutron.wsgi [req-05b5c451-9605-4c2e-87a0-44b06e6fc3ee None] 192.168.1.2 - - [29/Jul/2015 11:13:52] "GET /v2.0/ports.json?device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 890 0.022315
2015-07-29 11:13:52.263 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44819)
2015-07-29 11:13:52.280 2282 INFO neutron.wsgi [req-e6de32dc-0111-43af-83f8-e0f6e2e35ca8 None] 192.168.1.2 - - [29/Jul/2015 11:13:52] "GET /v2.0/security-groups.json?id=b6692f4f-f96e-48eb-a796-8df11fb6c16b HTTP/1.1" 200 1726 0.016793
2015-07-29 11:13:52.566 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44823)
2015-07-29 11:13:52.575 2282 INFO neutron.wsgi [req-86c923c4-10d8-4bba-8c42-2831dc71e24e None] 192.168.1.2 - - [29/Jul/2015 11:13:52] "GET /v2.0/extensions.json HTTP/1.1" 200 4302 0.006609
2015-07-29 11:14:39.861 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44827)
2015-07-29 11:14:39.863 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:14:39.943 2282 INFO neutron.wsgi [req-5e169013-35a4-4007-a88e-3a2883032115 None] 192.168.1.2 - - [29/Jul/2015 11:14:39] "GET /v2.0/ports.json?device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 890 0.080995
2015-07-29 11:14:39.944 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44829)
2015-07-29 11:14:39.961 2282 INFO neutron.wsgi [req-a30f0167-bf79-486b-a244-ce72fdcc578e None] 192.168.1.2 - - [29/Jul/2015 11:14:39] "GET /v2.0/security-groups.json?id=b6692f4f-f96e-48eb-a796-8df11fb6c16b HTTP/1.1" 200 1726 0.016655
2015-07-29 11:14:47.805 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52180)
2015-07-29 11:14:47.824 2282 INFO neutron.wsgi [req-26fcbb1e-8f5d-4b80-8063-5b7c6eb10931 None] 192.168.1.5 - - [29/Jul/2015 11:14:47] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.016296
2015-07-29 11:14:47.860 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52181)
2015-07-29 11:14:47.873 2282 INFO neutron.wsgi [req-1cec59ae-94d8-42a8-8e0e-b34d52a3374f None] 192.168.1.5 - - [29/Jul/2015 11:14:47] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.011921
2015-07-29 11:14:47.877 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52182)
2015-07-29 11:14:47.881 2282 INFO neutron.wsgi [req-8e626a77-f43b-4f61-b20f-b38d7d1a5146 None] 192.168.1.5 - - [29/Jul/2015 11:14:47] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.003802
2015-07-29 11:14:47.885 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52183)
2015-07-29 11:14:47.900 2282 INFO neutron.wsgi [req-49973dc1-0a89-4fdf-95d4-ba8fef19e17c None] 192.168.1.5 - - [29/Jul/2015 11:14:47] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.014417
2015-07-29 11:14:47.904 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52184)
2015-07-29 11:14:47.916 2282 INFO neutron.wsgi [req-79cfac25-0924-4ce7-a8a6-7f37470916d3 None] 192.168.1.5 - - [29/Jul/2015 11:14:47] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.011559
2015-07-29 11:15:48.069 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52192)
2015-07-29 11:15:48.085 2282 INFO neutron.wsgi [req-66b7b2f5-7831-4bb1-8c7d-1aba23ff0ee6 None] 192.168.1.5 - - [29/Jul/2015 11:15:48] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.013526
2015-07-29 11:15:48.118 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52193)
2015-07-29 11:15:48.128 2282 INFO neutron.wsgi [req-6924da74-2d7d-4625-97b9-0d2f2bf03dd5 None] 192.168.1.5 - - [29/Jul/2015 11:15:48] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.009445
2015-07-29 11:15:48.132 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52194)
2015-07-29 11:15:48.137 2282 INFO neutron.wsgi [req-0388024a-9477-4f0d-95cf-9c07618b3de7 None] 192.168.1.5 - - [29/Jul/2015 11:15:48] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.004223
2015-07-29 11:15:48.141 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52195)
2015-07-29 11:15:48.151 2282 INFO neutron.wsgi [req-86da4d41-863c-46ef-80b0-781801054186 None] 192.168.1.5 - - [29/Jul/2015 11:15:48] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.010079
2015-07-29 11:15:48.155 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52196)
2015-07-29 11:15:48.167 2282 INFO neutron.wsgi [req-1bd0ed0b-0e4c-463a-a146-2cf49994e697 None] 192.168.1.5 - - [29/Jul/2015 11:15:48] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.010833
2015-07-29 11:16:19.500 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44841)
2015-07-29 11:16:19.502 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.536 2282 INFO neutron.wsgi [req-9510288d-4a7c-4531-9d78-0fa7e74ee89c None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/ports.json?device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 890 0.035511
2015-07-29 11:16:19.537 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44843)
2015-07-29 11:16:19.552 2282 INFO neutron.wsgi [req-c1e6bffc-daba-463c-86c0-1fcd3d44facc None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/security-groups.json?id=b6692f4f-f96e-48eb-a796-8df11fb6c16b HTTP/1.1" 200 1726 0.014557
2015-07-29 11:16:19.615 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44846)
2015-07-29 11:16:19.617 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.646 2282 INFO neutron.wsgi [req-62f1f6f6-7dd8-4e93-b922-aa198bd931e8 None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/lb/vips.json HTTP/1.1" 404 242 0.030132
2015-07-29 11:16:19.658 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44848)
2015-07-29 11:16:19.660 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.690 2282 INFO neutron.wsgi [req-24cf8dfb-b61f-4eeb-afed-e3f5f99d2cff None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/vpn/ipsec-site-connections.json HTTP/1.1" 404 242 0.029553
2015-07-29 11:16:19.708 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44851)
2015-07-29 11:16:19.710 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.734 2282 INFO neutron.wsgi [req-5ff18460-0bd9-4fc3-9857-9622d902e664 None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/lb/members.json HTTP/1.1" 404 242 0.024793
2015-07-29 11:16:19.742 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44853)
2015-07-29 11:16:19.744 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.774 2282 INFO neutron.wsgi [req-1a5319c1-8a0c-45e3-b7a2-82420f0ff8de None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/fw/firewall_policies.json HTTP/1.1" 404 242 0.029860
2015-07-29 11:16:19.816 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44858)
2015-07-29 11:16:19.819 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.848 2282 INFO neutron.wsgi [req-42e9d62f-ac71-4742-b7e4-c48248402acf None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/floatingips.json?tenant_id=f41a56a0ca3d4ef982fadb9b2363c09f HTTP/1.1" 200 208 0.029809
2015-07-29 11:16:19.849 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44860)
2015-07-29 11:16:19.868 2282 INFO neutron.wsgi [req-167f740f-6079-4aa9-8516-9875aa7aab73 None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/networks.json?router%3Aexternal=True HTTP/1.1" 200 567 0.018023
2015-07-29 11:16:19.869 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44861)
2015-07-29 11:16:19.893 2282 INFO neutron.wsgi [req-58b47d7e-9dea-410d-93e6-000dd36d4246 None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/ports.json?tenant_id=f41a56a0ca3d4ef982fadb9b2363c09f HTTP/1.1" 200 202 0.023137
2015-07-29 11:16:19.894 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44862)
2015-07-29 11:16:19.896 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.927 2282 INFO neutron.wsgi [req-9d43819e-d21e-4454-b79d-20969f786185 None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/lb/health_monitors.json HTTP/1.1" 404 242 0.032373
2015-07-29 11:16:19.936 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44865)
2015-07-29 11:16:19.939 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:19.959 2282 INFO neutron.wsgi [req-0033d040-b116-4279-9ccb-ba59a17632e1 None] 192.168.1.2 - - [29/Jul/2015 11:16:19] "GET /v2.0/lb/pools.json HTTP/1.1" 404 242 0.021986
2015-07-29 11:16:20.108 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44872)
2015-07-29 11:16:20.111 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:20.631 2282 INFO neutron.wsgi [req-0140c578-f7e2-48c1-ab49-28bc4243e80c None] 192.168.1.2 - - [29/Jul/2015 11:16:20] "GET /v2.0/vpn/vpnservices.json HTTP/1.1" 404 242 0.521097
2015-07-29 11:16:20.633 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.2', 44874)
2015-07-29 11:16:20.635 2282 INFO urllib3.connectionpool [-] Starting new HTTP connection (1): controller
2015-07-29 11:16:20.659 2282 INFO neutron.wsgi [req-1e3557e2-1e9e-473f-ab78-d6b23f775582 None] 192.168.1.2 - - [29/Jul/2015 11:16:20] "GET /v2.0/fw/firewalls.json HTTP/1.1" 404 242 0.024444
2015-07-29 11:16:41.473 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52203)
2015-07-29 11:16:41.495 2282 INFO neutron.wsgi [req-02c46b3a-d857-4f74-9399-d36e1d645a48 None] 192.168.1.5 - - [29/Jul/2015 11:16:41] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.020610
2015-07-29 11:16:41.539 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52204)
2015-07-29 11:16:41.554 2282 INFO neutron.wsgi [req-9008ebf3-55f2-41f2-90dd-69dfabbe0c95 None] 192.168.1.5 - - [29/Jul/2015 11:16:41] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.013880
2015-07-29 11:16:41.556 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52205)
2015-07-29 11:16:41.560 2282 INFO neutron.wsgi [req-7c60e467-ed25-46f5-9712-051c111de617 None] 192.168.1.5 - - [29/Jul/2015 11:16:41] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.003210
2015-07-29 11:16:41.563 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52206)
2015-07-29 11:16:41.570 2282 INFO neutron.wsgi [req-47a52ffe-97db-4006-98eb-6942076c9359 None] 192.168.1.5 - - [29/Jul/2015 11:16:41] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.006393
2015-07-29 11:16:41.572 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52207)
2015-07-29 11:16:41.583 2282 INFO neutron.wsgi [req-c2ba26b5-b04a-4fc8-8ac5-d75ad7af3592 None] 192.168.1.5 - - [29/Jul/2015 11:16:41] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.010027
2015-07-29 11:17:43.804 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52210)
2015-07-29 11:17:43.851 2282 INFO neutron.wsgi [req-b88a23df-b8b4-454b-8d06-98644c782285 None] 192.168.1.5 - - [29/Jul/2015 11:17:43] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.046248
2015-07-29 11:17:43.947 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52211)
2015-07-29 11:17:43.973 2282 INFO neutron.wsgi [req-474f1a60-81c1-455d-85ed-174469b3cd63 None] 192.168.1.5 - - [29/Jul/2015 11:17:43] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.020573
2015-07-29 11:17:43.979 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52212)
2015-07-29 11:17:43.984 2282 INFO neutron.wsgi [req-14700758-13ef-4568-810e-f2de0fb722ef None] 192.168.1.5 - - [29/Jul/2015 11:17:43] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.004114
2015-07-29 11:17:43.987 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52213)
2015-07-29 11:17:44.003 2282 INFO neutron.wsgi [req-f97125da-3b2d-4ca4-843d-f9e81674c553 None] 192.168.1.5 - - [29/Jul/2015 11:17:44] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.015765
2015-07-29 11:17:44.007 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52214)
2015-07-29 11:17:44.038 2282 INFO neutron.wsgi [req-65821d2a-df42-40b1-ae3b-003c8d89383e None] 192.168.1.5 - - [29/Jul/2015 11:17:44] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.030204
2015-07-29 11:18:44.469 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52215)
2015-07-29 11:18:44.485 2282 INFO neutron.wsgi [req-8d360b7a-654b-42fd-b0c3-09dc77d41333 None] 192.168.1.5 - - [29/Jul/2015 11:18:44] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.015145
2015-07-29 11:18:44.569 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52216)
2015-07-29 11:18:44.581 2282 INFO neutron.wsgi [req-f89e6f2f-0c8d-404a-8ccc-1b0d530258e9 None] 192.168.1.5 - - [29/Jul/2015 11:18:44] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.012024
2015-07-29 11:18:44.586 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52217)
2015-07-29 11:18:44.592 2282 INFO neutron.wsgi [req-4664aa8f-10be-4681-a714-4e1dfad4a943 None] 192.168.1.5 - - [29/Jul/2015 11:18:44] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.004817
2015-07-29 11:18:44.595 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52218)
2015-07-29 11:18:44.604 2282 INFO neutron.wsgi [req-9580f303-fe21-4226-b239-bf4e5f96da1a None] 192.168.1.5 - - [29/Jul/2015 11:18:44] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.008424
2015-07-29 11:18:44.608 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52219)
2015-07-29 11:18:44.636 2282 INFO neutron.wsgi [req-f1b70c57-6cf4-451d-9d14-64923125154d None] 192.168.1.5 - - [29/Jul/2015 11:18:44] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.025100
2015-07-29 11:19:46.465 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52220)
2015-07-29 11:19:46.480 2282 INFO neutron.wsgi [req-5f6ba9a0-8931-4b88-93aa-44fec4cfe0ea None] 192.168.1.5 - - [29/Jul/2015 11:19:46] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.013275
2015-07-29 11:19:46.517 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52221)
2015-07-29 11:19:46.540 2282 INFO neutron.wsgi [req-c79a619e-6b96-42c0-97c8-cc49346cc899 None] 192.168.1.5 - - [29/Jul/2015 11:19:46] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.019459
2015-07-29 11:19:46.542 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52222)
2015-07-29 11:19:46.548 2282 INFO neutron.wsgi [req-b07438d7-209d-4ef9-9471-7114fd206c0d None] 192.168.1.5 - - [29/Jul/2015 11:19:46] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.004430
2015-07-29 11:19:46.550 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52223)
2015-07-29 11:19:46.569 2282 INFO neutron.wsgi [req-9e0a2047-0a88-453e-a74a-3521562ca7ce None] 192.168.1.5 - - [29/Jul/2015 11:19:46] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.013845
2015-07-29 11:19:46.573 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52224)
2015-07-29 11:19:46.595 2282 INFO neutron.wsgi [req-764e383d-0c73-4272-9742-7a8ccbe517f9 None] 192.168.1.5 - - [29/Jul/2015 11:19:46] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.019091
2015-07-29 11:20:46.467 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52225)
2015-07-29 11:20:46.483 2282 INFO neutron.wsgi [req-ebbeb3e6-19c7-4605-9afc-325c05372134 None] 192.168.1.5 - - [29/Jul/2015 11:20:46] "GET /v2.0/ports.json?tenant_id=50d58b42ce7043ac8f37d564fe1fb11c&device_id=52c3d98f-f99c-4d42-969b-16308cbf9db4 HTTP/1.1" 200 914 0.015388
2015-07-29 11:20:46.559 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52226)
2015-07-29 11:20:46.583 2282 INFO neutron.wsgi [req-4a0cdc3e-2738-4100-8126-98d1eb54bcfb None] 192.168.1.5 - - [29/Jul/2015 11:20:46] "GET /v2.0/networks.json?id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a HTTP/1.1" 200 591 0.023044
2015-07-29 11:20:46.591 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52227)
2015-07-29 11:20:46.597 2282 INFO neutron.wsgi [req-e9b58bde-5639-4a67-81e8-5dfb2b4405dd None] 192.168.1.5 - - [29/Jul/2015 11:20:46] "GET /v2.0/floatingips.json?fixed_ip_address=10.1.160.133&port_id=6b6b034d-ea2e-410a-9ff2-2e7fd8765a86 HTTP/1.1" 200 232 0.005366
2015-07-29 11:20:46.600 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52228)
2015-07-29 11:20:46.615 2282 INFO neutron.wsgi [req-dae26f14-a50b-4ab2-8bfc-65a40bd21df6 None] 192.168.1.5 - - [29/Jul/2015 11:20:46] "GET /v2.0/subnets.json?id=1a112b9c-1e4f-4545-bed0-1878a768c37f HTTP/1.1" 200 651 0.014688
2015-07-29 11:20:46.618 2282 INFO neutron.wsgi [-] (2282) accepted ('192.168.1.5', 52229)
2015-07-29 11:20:46.636 2282 INFO neutron.wsgi [req-85fe5752-b628-4c3c-a00d-903b3c811fab None] 192.168.1.5 - - [29/Jul/2015 11:20:46] "GET /v2.0/ports.json?network_id=2f9ce38e-28cd-4a42-b76d-e8cc072fca5a&device_owner=network%3Adhcp HTTP/1.1" 200 226 0.016777


________________________________
De : Kevin Benton [blak111 at gmail.com]
Date d'envoi : mardi 28 juillet 2015 23:54
À : Asmaa Chebba
Cc: Assaf Muller; OpenStack Operators
Objet : Re: RE : [Openstack-operators] Can't launch docker instance, Unexpected vif_type=binding_failed.

We also need to see the /etc/neutron/plugins/ml2/ml2_conf.ini from both because that has the physical network mappings.

Also, I don't see anything obvious in the agent logs there. Can you include the portion surrounding the "Failed to bind port" message from the Neutron server log?

On Tue, Jul 28, 2015 at 4:13 AM, Asmaa Chebba <achebba at cdta.dz<mailto:achebba at cdta.dz>> wrote:
openvswitch agent is running and the logs in compute2 are as follow:

1. OVS-cleanup.log
2015-06-20 12:52:19.976 1529 INFO neutron.agent.ovs_cleanup_util [-] OVS cleanup completed successfully
2015-06-23 15:48:43.401 1332 INFO neutron.common.config [-] Logging enabled!
2015-06-23 15:48:43.893 1332 INFO neutron.agent.ovs_cleanup_util [-] Cleaning br-int
2015-06-23 15:48:44.520 1332 INFO neutron.agent.ovs_cleanup_util [-] OVS cleanup completed successfully
2015-06-24 11:49:21.423 1770 INFO neutron.common.config [-] Logging enabled!
2015-06-24 11:49:22.123 1770 INFO neutron.agent.ovs_cleanup_util [-] Cleaning br-int
2015-06-24 11:49:22.628 1770 INFO neutron.agent.ovs_cleanup_util [-] OVS cleanup completed successfully
2015-06-25 00:21:55.634 1337 INFO neutron.common.config [-] Logging enabled!
2015-06-25 00:21:56.858 1337 INFO neutron.agent.ovs_cleanup_util [-] Cleaning br-int
2015-06-25 00:21:57.900 1337 INFO neutron.agent.ovs_cleanup_util [-] OVS cleanup completed successfully
2015-07-07 16:43:42.608 1457 INFO neutron.common.config [-] Logging enabled!
2015-07-07 16:43:43.399 1457 INFO neutron.agent.ovs_cleanup_util [-] Cleaning br-int
2015-07-07 16:43:43.792 1457 INFO neutron.agent.ovs_cleanup_util [-] OVS cleanup completed successfully
2015-07-08 15:04:31.954 1351 INFO neutron.common.config [-] Logging enabled!
2015-07-08 15:04:32.888 1351 INFO neutron.agent.ovs_cleanup_util [-] Cleaning br-int
2015-07-08 15:04:33.235 1351 INFO neutron.agent.ovs_cleanup_util [-] OVS cleanup completed successfully
2015-07-20 13:25:20.300 1550 INFO neutron.common.config [-] Logging enabled!
2015-07-20 13:25:22.665 1550 INFO neutron.agent.ovs_cleanup_util [-] Cleaning br-int
2015-07-20 13:25:22.770 1550 INFO neutron.agent.ovs_cleanup_util [-] OVS cleanup completed succe

2. Openvswitch-agent.log
2015-07-28 13:23:29.151 4615 ERROR neutron.agent.linux.ovsdb_monitor [-] Error received from ovsdb monitor: 2015-07-28T11:23:29Z|00001|fatal_signal|WARN|terminating with signal 15 (Terminated)
2015-07-28 13:23:29.190 4615 ERROR neutron.agent.linux.utils [-]
Command: ['ps', '--ppid', '4764', '-o', 'pid=']
Exit code: 1
Stdout: ''
Stderr: ''
2015-07-28 13:23:29.835 4615 CRITICAL neutron [req-dbf6bc78-c2df-4454-9e19-5f09bf688ee9 None] AssertionError: Trying to re-send() an already-triggered event.
2015-07-28 13:23:29.835 4615 TRACE neutron Traceback (most recent call last):
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/bin/neutron-openvswitch-agent", line 10, in <module>
2015-07-28 13:23:29.835 4615 TRACE neutron     sys.exit(main())
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/plugins/openvswitch/agent/ovs_neutron_agent.py", line 1565, in main
2015-07-28 13:23:29.835 4615 TRACE neutron     agent.daemon_loop()
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/plugins/openvswitch/agent/ovs_neutron_agent.py", line 1485, in daemon_loop
2015-07-28 13:23:29.835 4615 TRACE neutron     self.rpc_loop(polling_manager=pm)
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/contextlib.py", line 24, in __exit__
2015-07-28 13:23:29.835 4615 TRACE neutron     self.gen.next()
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/agent/linux/polling.py", line 39, in get_polling_manager
2015-07-28 13:23:29.835 4615 TRACE neutron     pm.stop()
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/agent/linux/polling.py", line 106, in stop
2015-07-28 13:23:29.835 4615 TRACE neutron     self._monitor.stop()
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/agent/linux/async_process.py", line 89, in stop
2015-07-28 13:23:29.835 4615 TRACE neutron     self._kill()
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/agent/linux/ovsdb_monitor.py", line 99, in _kill
2015-07-28 13:23:29.835 4615 TRACE neutron     super(SimpleInterfaceMonitor, self)._kill(*args, **kwargs)
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/neutron/agent/linux/async_process.py", line 116, in _kill
2015-07-28 13:23:29.835 4615 TRACE neutron     self._kill_event.send()
2015-07-28 13:23:29.835 4615 TRACE neutron   File "/usr/lib/python2.7/dist-packages/eventlet/event.py", line 150, in send
2015-07-28 13:23:29.835 4615 TRACE neutron     assert self._result is NOT_USED, 'Trying to re-send() an already-triggered event.'
2015-07-28 13:23:29.835 4615 TRACE neutron AssertionError: Trying to re-send() an already-triggered event.
2015-07-28 13:23:29.835 4615 TRACE neutron
2015-07-28 13:23:32.197 6195 INFO neutron.common.config [-] Logging enabled!
2015-07-28 13:23:33.005 6195 INFO oslo.messaging._drivers.impl_rabbit [-] Connecting to AMQP server on controller:5672
2015-07-28 13:23:33.120 6195 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on controller:5672
2015-07-28 13:23:33.126 6195 INFO oslo.messaging._drivers.impl_rabbit [-] Connecting to AMQP server on controller:5672
2015-07-28 13:23:33.143 6195 INFO oslo.messaging._drivers.impl_rabbit [-] Connected to AMQP server on controller:5672
2015-07-28 13:23:34.287 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connecting to AMQP server on controller:5672
2015-07-28 13:23:34.304 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connected to AMQP server on controller:5672
2015-07-28 13:23:34.315 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connecting to AMQP server on controller:5672
2015-07-28 13:23:34.321 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connected to AMQP server on controller:5672
2015-07-28 13:23:34.327 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connecting to AMQP server on controller:5672
2015-07-28 13:23:34.333 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connected to AMQP server on controller:5672
2015-07-28 13:23:34.338 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connecting to AMQP server on controller:5672
2015-07-28 13:23:34.344 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connected to AMQP server on controller:5672
2015-07-28 13:23:34.349 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connecting to AMQP server on controller:5672
2015-07-28 13:23:34.356 6195 INFO oslo.messaging._drivers.impl_rabbit [req-15e7e089-2323-4101-811e-ff2537fe3c27 ] Connected to AMQP server on controller:5672
2015-07-28 13:23:34.360 6195 INFO neutron.plugins.openvswitch.agent.ovs_neutron_agent [req-15e7e089-2323-4101-811e-ff2537fe3c27 None] Agent initialized successfully, now running...
2015-07-28 13:23:34.367 6195 INFO neutron.plugins.openvswitch.agent.ovs_neutron_agent [req-15e7e089-2323-4101-811e-ff2537fe3c27 None] Agent out of sync with plugin!
2015-07-28 13:23:34.447 6195 INFO neutron.plugins.openvswitch.agent.ovs_neutron_agent [req-15e7e089-2323-4101-811e-ff2537fe3c27 None] Agent tunnel out of sync with plugin!


3. Openvswitch-agent.log.1 ==>
2015-07-26 12:15:51.431 4615 INFO neutron.agent.securitygroups_rpc [req-8d59b5d6-4b0f-4ced-a336-5a94159ac601 None] Security group member updated [u'b6692f4f-f96e-48eb-a796-8df11fb6c16b']


- And the result of ovs-vsctl show:

0a578213-5de5-48fd-923e-14b7b201c6c8
    Bridge br-int
        fail_mode: secure
        Port br-int
            Interface br-int
                type: internal
        Port patch-tun
            Interface patch-tun
                type: patch
                options: {peer=patch-int}
    Bridge br-tun
        fail_mode: secure
        Port "gre-c0a80204"
            Interface "gre-c0a80204"
                type: gre
                options: {df_default="true", in_key=flow, local_ip="192.168.2.5", out_key=flow, remote_ip="192.168.2.4"}
        Port br-tun
            Interface br-tun
                type: internal
        Port patch-int
            Interface patch-int
                type: patch
                options: {peer=patch-tun}
        Port "gre-c0a80203"
            Interface "gre-c0a80203"
                type: gre
                options: {df_default="true", in_key=flow, local_ip="192.168.2.5", out_key=flow, remote_ip="192.168.2.3"}
        Port "gre-c0a80202"
            Interface "gre-c0a80202"
                type: gre
                options: {df_default="true", in_key=flow, local_ip="192.168.2.5", out_key=flow, remote_ip="192.168.2.2"}
    ovs_version: "2.0.2"

As for the configuration, here is the files of neutron.conf:

1. ON compute
[DEFAULT]
verbose = True
lock_path = $state_path/lock
core_plugin = ml2
service_plugins = router
auth_strategy = keystone
allow_overlapping_ips = True
rabbit_host=controller

[agent]
root_helper = sudo /usr/bin/neutron-rootwrap /etc/neutron/rootwrap.conf

[keystone_authtoken]
auth_uri = http://controller:5000/v2.0
identity_uri = http://controller:35357
admin_tenant_name = service
admin_user = neutron
admin_password = PASSWORD

[service_providers]
service_provider=LOADBALANCER:Haproxy:neutron.services.loadbalancer.drivers.haproxy.plugin_driver.HaproxyOnHostPluginDriver:default
service_provider=VPN:openswan:neutron.services.vpn.service_drivers.ipsec.IPsecVPNDriver:default

2. ON controller
[DEFAULT]
verbose = True
lock_path = $state_path/lock
core_plugin = ml2
service_plugins = router
auth_strategy = keystone
allow_overlapping_ips = True
agent_down_time = 1000
notify_nova_on_port_status_changes = True
notify_nova_on_port_data_changes = True
nova_url = http://controller:8774/v2
nova_region_name = regionOne
nova_admin_username = nova
nova_admin_tenant_id =f41a56a0ca3d4ef982fadb9b2363c09f
nova_admin_password = PASSWORD
nova_admin_auth_url = http://controller:35357/v2.0
rabbit_host=controller
rabbit_password=PASSWORD
rpc_backend=rabbit

[agent]
root_helper = sudo /usr/bin/neutron-rootwrap /etc/neutron/rootwrap.conf
report_interval = 100

[keystone_authtoken]
auth_uri = http://controller:5000/v2.0
identity_uri = http://controller:35357
admin_tenant_name = service
admin_user = neutron
admin_password = PASSWORD

[database]
connection = mysql://neutron:PASSWORD@controller/neutron

[service_providers]
service_provider=LOADBALANCER:Haproxy:neutron.services.loadbalancer.drivers.haproxy.plugin_driver.HaproxyOnHostPluginDriver:default
service_provider=VPN:openswan:neutron.services.vpn.service_drivers.ipsec.IPsecVPNDriver:default

Thanks.
________________________________________
De : Assaf Muller [amuller at redhat.com<mailto:amuller at redhat.com>]
Date d'envoi : lundi 27 juillet 2015 15:13
À : Kevin Benton
Cc: Asmaa Chebba; OpenStack Operators
Objet : Re: [Openstack-operators] Can't launch docker instance, Unexpected vif_type=binding_failed.

Also can you paste the configuration for both the OVS agent and your neutron server? Binding failure is almost always a configuration mismatch.

----- Original Message -----
>
>
> Is the neutron openvswitch agent running on host compute2? What do the logs
> say for the agent there?
> On Jul 22, 2015 07:22, "Asmaa Chebba" < achebba at cdta.dz<mailto:achebba at cdta.dz> > wrote:
>
>
>
> Hi,
> I installed Docker with juno release on Ubuntu
> all compute/networking services are up and enabled, and I can add docker
> images with glance however, I can't launch an instance (stopped at spawning
> step)
> in the nova-compute log, I found :
> Instance failed to spawn
> InstanceDeployFailure: Cannot setup network: Unexpected
> vif_type=binding_failed
> and when verifying the neutron-server log:
> Failed to bind port 5d299cc9-e3f3-48a0-a80f-f204910a47e7 on host compute2
>
> Any idea on how to solve this?
> I appriciate your help.
> Tahnks.
>
>
>
>
> _______________________________________________
> OpenStack-operators mailing list
> OpenStack-operators at lists.openstack.org<mailto:OpenStack-operators at lists.openstack.org>
> http://lists.openstack.org/cgi-bin/mailman/listinfo/openstack-operators
>
>
> _______________________________________________
> OpenStack-operators mailing list
> OpenStack-operators at lists.openstack.org<mailto:OpenStack-operators at lists.openstack.org>
> http://lists.openstack.org/cgi-bin/mailman/listinfo/openstack-operators
>



--
Kevin Benton
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.openstack.org/pipermail/openstack-operators/attachments/20150729/0f5bc0e9/attachment.html>


More information about the OpenStack-operators mailing list