2015-08-21 04:29:43.216 9644 INFO neutron.wsgi [req-5bf6a2b0-e50e-47f2-b8fa-0ee1a757f499 ] 127.0.0.1 - - [21/Aug/2015 04:29:43] "GET /v2.0/ports/620187c5-b4ac-4aca-bdeb-96205503344d.json?fields=binding%3Avnic_type&fields=network_id HTTP/1.1" 200 308 0.063451 2015-08-21 04:29:43.233 9644 INFO neutron.wsgi [req-07cefbe3-fb59-497a-b88f-c4149939d2d9 ] 127.0.0.1 - - [21/Aug/2015 04:29:43] "GET /v2.0/networks/db078c2d-63f1-40c0-b6c3-b49de487362b.json?fields=provider%3Aphysical_network HTTP/1.1" 200 267 0.015045 2015-08-21 04:29:43.822 9644 INFO neutron.wsgi [req-9db2a3dd-605d-4328-a60b-eacd81adc124 ] 127.0.0.1 - - [21/Aug/2015 04:29:43] "GET /v2.0/ports.json?device_id=baab9ba5-80e8-45f7-b86a-8ac3ce8ba944 HTTP/1.1" 200 226 0.017998 2015-08-21 04:29:43.973 9644 INFO neutron.wsgi [-] (9644) accepted ('127.0.0.1', 38567) 2015-08-21 04:29:43.999 9644 INFO neutron.wsgi [req-db1ba791-274d-4693-87cc-9f023599cae7 ] 127.0.0.1 - - [21/Aug/2015 04:29:43] "GET /v2.0/ports.json?device_id=baab9ba5-80e8-45f7-b86a-8ac3ce8ba944&device_id=808ba0d6-3986-4d8b-b752-8e224610e1e6&device_id=dd180ac1-08d1-4df3-b895-a5f836e9363f&device_id=953c479e-3143-402f-9b40-c2d8848c2b93 HTTP/1.1" 200 2388 0.024552 2015-08-21 04:29:44.016 9644 INFO neutron.wsgi [req-449b680f-f962-47ff-9343-f0be294af7c8 ] 127.0.0.1 - - [21/Aug/2015 04:29:44] "GET /v2.0/security-groups.json?id=8e12a661-09b5-41ac-ade8-fddf6d997262 HTTP/1.1" 200 1765 0.014528 2015-08-21 04:29:44.453 9644 INFO neutron.wsgi [req-abed95a6-487c-4972-bd7c-6b47ab9d26ed ] 10.254.4.53 - - [21/Aug/2015 04:29:44] "GET /v2.0/ports/620187c5-b4ac-4aca-bdeb-96205503344d.json HTTP/1.1" 200 847 0.016895 2015-08-21 04:29:44.472 9644 INFO neutron.wsgi [req-f32158b7-c59d-487b-87f7-b4d8335b6e43 ] 10.254.4.53 - - [21/Aug/2015 04:29:44] "GET /v2.0/networks.json?id=db078c2d-63f1-40c0-b6c3-b49de487362b HTTP/1.1" 200 600 0.015877 2015-08-21 04:29:44.489 9644 INFO neutron.wsgi [req-589f7107-d6e6-4920-84b6-a7b92716a6ca ] 10.254.4.53 - - [21/Aug/2015 04:29:44] "GET /v2.0/security-groups.json?tenant_id=85aa4ef08044470dab1608395e5cac26 HTTP/1.1" 200 1765 0.014448 2015-08-21 04:29:44.494 9644 DEBUG oslo_messaging._drivers.amqp [req-314733e3-17ab-4e20-951a-0c75744016b5 ] UNIQUE_ID is 3df0d975d52b4ca9a75069b1534d2c48. _add_unique_id /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqp.py:258 2015-08-21 04:29:44.497 9644 DEBUG neutron.api.v2.base [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Request body: {u'port': {u'binding:profile': {u'pci_slot': u'0000:09:11.5', u'physical_network': u'external', u'pci_vendor_info': u'8086:1520'}, u'device_owner': u'compute:None', u'binding:host_id': u'compute', u'device_id': u'baab9ba5-80e8-45f7-b86a-8ac3ce8ba944'}} prepare_request_body /usr/lib/python2.7/site-packages/neutron/api/v2/base.py:597 2015-08-21 04:29:44.514 9644 DEBUG oslo_concurrency.lockutils [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Acquired semaphore "db-access" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:391 2015-08-21 04:29:44.605 9644 DEBUG oslo_concurrency.lockutils [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Releasing semaphore "db-access" lock /usr/lib/python2.7/site-packages/oslo_concurrency/lockutils.py:404 2015-08-21 04:29:44.605 9644 INFO neutron.callbacks.manager [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Notify callbacks for port, after_update 2015-08-21 04:29:44.605 9644 INFO neutron.callbacks.manager [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Calling callback neutron.db.l3_dvrscheduler_db._notify_l3_agent_new_port 2015-08-21 04:29:44.605 9644 DEBUG neutron.db.l3_dvrscheduler_db [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Received port after_update _notify_l3_agent_new_port /usr/lib/python2.7/site-packages/neutron/db/l3_dvrscheduler_db.py:331 2015-08-21 04:29:44.617 9644 DEBUG neutron.db.l3_dvrscheduler_db [req-314733e3-17ab-4e20-951a-0c75744016b5 ] DVR: dvr_update_router_addvm None dvr_update_router_addvm /usr/lib/python2.7/site-packages/neutron/db/l3_dvrscheduler_db.py:118 2015-08-21 04:29:44.619 9644 DEBUG neutron.plugins.ml2.managers [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Attempting to bind port 620187c5-b4ac-4aca-bdeb-96205503344d on host compute for vnic_type direct with profile {"pci_slot": "0000:09:11.5", "physical_network": "external", "pci_vendor_info": "8086:1520"} bind_port /usr/lib/python2.7/site-packages/neutron/plugins/ml2/managers.py:611 2015-08-21 04:29:44.619 9644 DEBUG neutron.plugins.ml2.managers [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Attempting to bind port 620187c5-b4ac-4aca-bdeb-96205503344d on host compute at level 0 using segments [{'segmentation_id': None, 'physical_network': u'external', 'id': u'f3dee69f-ee4a-4c1b-bfa9-05689dc9b07b', 'network_type': u'flat'}] _bind_port_level /usr/lib/python2.7/site-packages/neutron/plugins/ml2/managers.py:628 2015-08-21 04:29:44.620 9644 DEBUG neutron.plugins.ml2.drivers.mech_agent [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Attempting to bind port 620187c5-b4ac-4aca-bdeb-96205503344d on network db078c2d-63f1-40c0-b6c3-b49de487362b bind_port /usr/lib/python2.7/site-packages/neutron/plugins/ml2/drivers/mech_agent.py:60 2015-08-21 04:29:44.620 9644 DEBUG neutron.plugins.ml2.drivers.mech_agent [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Refusing to bind due to unsupported vnic_type: direct bind_port /usr/lib/python2.7/site-packages/neutron/plugins/ml2/drivers/mech_agent.py:65 2015-08-21 04:29:44.620 9644 DEBUG neutron.plugins.ml2.drivers.mech_sriov.mech_driver [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Attempting to bind port 620187c5-b4ac-4aca-bdeb-96205503344d on network db078c2d-63f1-40c0-b6c3-b49de487362b bind_port /usr/lib/python2.7/site-packages/neutron/plugins/ml2/drivers/mech_sriov/mech_driver.py:97 2015-08-21 04:29:44.623 9644 DEBUG neutron.plugins.ml2.drivers.mech_sriov.mech_driver [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Checking agent: {'binary': u'neutron-sriov-nic-agent', 'description': None, 'admin_state_up': True, 'heartbeat_timestamp': datetime.datetime(2015, 8, 21, 8, 29, 18), 'alive': True, 'topic': u'N/A', 'host': u'compute', 'agent_type': u'NIC Switch agent', 'created_at': datetime.datetime(2015, 8, 18, 5, 19, 22), 'started_at': datetime.datetime(2015, 8, 21, 8, 23, 18), 'id': u'0e00843f-ab7f-436d-922a-7292c547f97b', 'configurations': {u'devices': 0, u'device_mappings': {}}} bind_port /usr/lib/python2.7/site-packages/neutron/plugins/ml2/drivers/mech_sriov/mech_driver.py:111 2015-08-21 04:29:44.623 9644 DEBUG neutron.plugins.ml2.drivers.mech_sriov.mech_driver [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Checking segment: {'segmentation_id': None, 'physical_network': u'external', 'id': u'f3dee69f-ee4a-4c1b-bfa9-05689dc9b07b', 'network_type': u'flat'} for mappings: {} check_segment /usr/lib/python2.7/site-packages/neutron/plugins/ml2/drivers/mech_sriov/mech_driver.py:145 2015-08-21 04:29:44.623 9644 ERROR neutron.plugins.ml2.managers [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Failed to bind port 620187c5-b4ac-4aca-bdeb-96205503344d on host compute 2015-08-21 04:29:44.623 9644 ERROR neutron.plugins.ml2.managers [req-314733e3-17ab-4e20-951a-0c75744016b5 ] Failed to bind port 620187c5-b4ac-4aca-bdeb-96205503344d on host compute