← Back to team overview

yahoo-eng-team team mailing list archive

[Bug 1596750] [NEW] Not specifying '--target-tenant' argument when executing "neutron rbac-create", returns 'Request Failed: internal server error while processing your request.'

 

Public bug reported:

Not specifying '--target-tenant' argument when executing "neutron rbac-create",returns 'Request Failed: internal server error while processing your request.'
The real reason is 'target_tenant' cannot be null

[root@localhost devstack]# neutron rbac-create net_xwj_01 --type network --action access_as_shared 
Request Failed: internal server error while processing your request.
Neutron server returns request_ids: ['req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7']
[root@localhost devstack]# 


                                                                                                                                            (pid=30998) __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:196
2016-06-27 21:52:28.142 DEBUG neutron.callbacks.manager [req-7f7b6327-6cfc-4765-8459-3e6b8fac8454 None None] Notify callbacks for agent, after_update from (pid=30998) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:140
2016-06-27 21:52:28.142 DEBUG neutron.callbacks.manager [req-7f7b6327-6cfc-4765-8459-3e6b8fac8454 None None] Calling callback neutron.services.segments.db._update_segment_host_mapping_for_agent from (pid=30998) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
2016-06-27 21:52:29.896 DEBUG neutron.wsgi [-] (31042) accepted ('192.168.1.176', 35055) from (pid=31042) server /usr/lib/python2.7/site-packages/eventlet/wsgi.py:868
2016-06-27 21:52:30.026 INFO neutron.wsgi [req-ba1735d0-b247-4cfa-b1ab-c32da9010f8c admin aced7a29bb134dec82307a880d1cc542] 192.168.1.176 - - [27/Jun/2016 21:52:30] "GET /v2.0/networks.json?fields=id&name=net_xwj_01 HTTP/1.1" 200 260 0.128562
2016-06-27 21:52:30.035 DEBUG neutron.api.v2.base [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Request body: {u'rbac_policy': {u'action': u'access_as_shared', u'object_type': u'network', u'target_tenant': None, u'object_id': u'7946e91a-3879-4fcd-928e-66a99ed30112'}} from (pid=31042) prepare_request_body /opt/stack/neutron/neutron/api/v2/base.py:660
2016-06-27 21:52:30.039 DEBUG neutron.db.quota.driver [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Resources member,subnetpool,health_monitor have unlimited quota limit. It is not required to calculate headroom  from (pid=31042) make_reservation /opt/stack/neutron/neutron/db/quota/driver.py:191
2016-06-27 21:52:30.047 DEBUG neutron.db.quota.driver [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Attempting to reserve 1 items for resource rbac_policy. Total usage: 3; quota limit: 10; headroom:7 from (pid=31042) make_reservation /opt/stack/neutron/neutron/db/quota/driver.py:223
2016-06-27 21:52:30.062 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Notify callbacks for rbac-policy, before_create from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:140
2016-06-27 21:52:30.062 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.services.network_ip_availability.plugin.NetworkIPAvailabilityPlugin.validate_network_rbac_policy_change from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
2016-06-27 21:52:30.128 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.plugins.ml2.plugin.Ml2Plugin.validate_network_rbac_policy_change from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
2016-06-27 21:52:30.193 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.plugins.ml2.plugin.Ml2Plugin._process_ext_policy_create from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
2016-06-27 21:52:30.193 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.objects.qos.policy.QosPolicy.validate_rbac_policy_change from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
2016-06-27 21:52:30.196 ERROR oslo_db.sqlalchemy.exc_filters [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] DBAPIError exception wrapped from (pymysql.err.IntegrityError) (1048, u"Column 'target_tenant' cannot be null") [SQL: u'INSERT INTO networkrbacs (tenant_id, id, target_tenant, action, object_id) VALUES (%(tenant_id)s, %(id)s, %(target_tenant)s, %(action)s, %(object_id)s)'] [parameters: {'action': u'access_as_shared', 'tenant_id': u'aced7a29bb134dec82307a880d1cc542', 'target_tenant': None, 'id': '55a20046-d828-4307-bd4d-577b18d602f0', 'object_id': u'7946e91a-3879-4fcd-928e-66a99ed30112'}]
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters Traceback (most recent call last):
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1139, in _execute_context
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     context)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/default.py", line 450, in do_execute
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     cursor.execute(statement, parameters)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 161, in execute
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     result = self._query(query)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 317, in _query
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     conn.query(q)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 835, in query
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     self._affected_rows = self._read_query_result(unbuffered=unbuffered)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1019, in _read_query_result
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     result.read()
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1302, in read
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     first_packet = self.connection._read_packet()
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 981, in _read_packet
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     packet.check_error()
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 393, in check_error
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     err.raise_mysql_exception(self._data)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 120, in raise_mysql_exception
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     _check_mysql_exception(errinfo)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 112, in _check_mysql_exception
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     raise errorclass(errno, errorvalue)
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters IntegrityError: (1048, u"Column 'target_tenant' cannot be null")
2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters 
2016-06-27 21:52:30.232 ERROR neutron.api.v2.resource [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] create failed
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource Traceback (most recent call last):
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/resource.py", line 78, in resource
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     result = method(request=request, **args)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 409, in create
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return self._create(request, body, **kwargs)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_db/api.py", line 148, in wrapper
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     ectxt.value = e.inner_exc
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 221, in __exit__
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.force_reraise()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 197, in force_reraise
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     six.reraise(self.type_, self.value, self.tb)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_db/api.py", line 138, in wrapper
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return f(*args, **kwargs)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 521, in _create
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     obj = do_create(body)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 503, in do_create
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     request.context, reservation.reservation_id)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 221, in __exit__
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.force_reraise()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 197, in force_reraise
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     six.reraise(self.type_, self.value, self.tb)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 496, in do_create
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return obj_creator(request.context, **kwargs)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/db/rbac_db_mixin.py", line 52, in create_rbac_policy
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     context.session.add(db_entry)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 490, in __exit__
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.rollback()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/util/langhelpers.py", line 60, in __exit__
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     compat.reraise(exc_type, exc_value, exc_tb)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 487, in __exit__
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.commit()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 392, in commit
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self._prepare_impl()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 372, in _prepare_impl
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.session.flush()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 2019, in flush
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self._flush(objects)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 2137, in _flush
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     transaction.rollback(_capture_exception=True)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/util/langhelpers.py", line 60, in __exit__
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     compat.reraise(exc_type, exc_value, exc_tb)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 2101, in _flush
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     flush_context.execute()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/unitofwork.py", line 373, in execute
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     rec.execute(self)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/unitofwork.py", line 532, in execute
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     uow
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/persistence.py", line 174, in save_obj
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     mapper, table, insert)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/persistence.py", line 800, in _emit_insert_statements
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     execute(statement, params)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 914, in execute
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return meth(self, multiparams, params)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/sql/elements.py", line 323, in _execute_on_connection
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return connection._execute_clauseelement(self, multiparams, params)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1010, in _execute_clauseelement
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     compiled_sql, distilled_params
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1146, in _execute_context
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     context)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1337, in _handle_dbapi_exception
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     util.raise_from_cause(newraise, exc_info)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/util/compat.py", line 202, in raise_from_cause
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     reraise(type(exception), exception, tb=exc_tb, cause=cause)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1139, in _execute_context
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     context)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/default.py", line 450, in do_execute
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     cursor.execute(statement, parameters)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 161, in execute
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     result = self._query(query)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 317, in _query
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     conn.query(q)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 835, in query
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self._affected_rows = self._read_query_result(unbuffered=unbuffered)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1019, in _read_query_result
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     result.read()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1302, in read
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     first_packet = self.connection._read_packet()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 981, in _read_packet
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     packet.check_error()
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 393, in check_error
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     err.raise_mysql_exception(self._data)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 120, in raise_mysql_exception
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     _check_mysql_exception(errinfo)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 112, in _check_mysql_exception
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     raise errorclass(errno, errorvalue)
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource DBError: (pymysql.err.IntegrityError) (1048, u"Column 'target_tenant' cannot be null") [SQL: u'INSERT INTO networkrbacs (tenant_id, id, target_tenant, action, object_id) VALUES (%(tenant_id)s, %(id)s, %(target_tenant)s, %(action)s, %(object_id)s)'] [parameters: {'action': u'access_as_shared', 'tenant_id': u'aced7a29bb134dec82307a880d1cc542', 'target_tenant': None, 'id': '55a20046-d828-4307-bd4d-577b18d602f0', 'object_id': u'7946e91a-3879-4fcd-928e-66a99ed30112'}]
2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource 
2016-06-27 21:52:30.239 INFO neutron.wsgi [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] 192.168.1.176 - - [27/Jun/2016 21:52:30] "POST /v2.0/rbac-policies.json HTTP/1.1" 500 368 0.208457

                                                                                                                                            
[detached from 11701.stack]
bash-4.2$

** Affects: neutron
     Importance: Undecided
     Assignee: JianGang Weng (weng-jiangang)
         Status: New

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to neutron.
https://bugs.launchpad.net/bugs/1596750

Title:
  Not specifying '--target-tenant' argument when executing "neutron
  rbac-create",returns 'Request Failed: internal server error while
  processing your request.'

Status in neutron:
  New

Bug description:
  Not specifying '--target-tenant' argument when executing "neutron rbac-create",returns 'Request Failed: internal server error while processing your request.'
  The real reason is 'target_tenant' cannot be null

  [root@localhost devstack]# neutron rbac-create net_xwj_01 --type network --action access_as_shared 
  Request Failed: internal server error while processing your request.
  Neutron server returns request_ids: ['req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7']
  [root@localhost devstack]# 

  
                                                                                                                                              (pid=30998) __call__ /usr/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:196
  2016-06-27 21:52:28.142 DEBUG neutron.callbacks.manager [req-7f7b6327-6cfc-4765-8459-3e6b8fac8454 None None] Notify callbacks for agent, after_update from (pid=30998) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:140
  2016-06-27 21:52:28.142 DEBUG neutron.callbacks.manager [req-7f7b6327-6cfc-4765-8459-3e6b8fac8454 None None] Calling callback neutron.services.segments.db._update_segment_host_mapping_for_agent from (pid=30998) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
  2016-06-27 21:52:29.896 DEBUG neutron.wsgi [-] (31042) accepted ('192.168.1.176', 35055) from (pid=31042) server /usr/lib/python2.7/site-packages/eventlet/wsgi.py:868
  2016-06-27 21:52:30.026 INFO neutron.wsgi [req-ba1735d0-b247-4cfa-b1ab-c32da9010f8c admin aced7a29bb134dec82307a880d1cc542] 192.168.1.176 - - [27/Jun/2016 21:52:30] "GET /v2.0/networks.json?fields=id&name=net_xwj_01 HTTP/1.1" 200 260 0.128562
  2016-06-27 21:52:30.035 DEBUG neutron.api.v2.base [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Request body: {u'rbac_policy': {u'action': u'access_as_shared', u'object_type': u'network', u'target_tenant': None, u'object_id': u'7946e91a-3879-4fcd-928e-66a99ed30112'}} from (pid=31042) prepare_request_body /opt/stack/neutron/neutron/api/v2/base.py:660
  2016-06-27 21:52:30.039 DEBUG neutron.db.quota.driver [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Resources member,subnetpool,health_monitor have unlimited quota limit. It is not required to calculate headroom  from (pid=31042) make_reservation /opt/stack/neutron/neutron/db/quota/driver.py:191
  2016-06-27 21:52:30.047 DEBUG neutron.db.quota.driver [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Attempting to reserve 1 items for resource rbac_policy. Total usage: 3; quota limit: 10; headroom:7 from (pid=31042) make_reservation /opt/stack/neutron/neutron/db/quota/driver.py:223
  2016-06-27 21:52:30.062 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Notify callbacks for rbac-policy, before_create from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:140
  2016-06-27 21:52:30.062 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.services.network_ip_availability.plugin.NetworkIPAvailabilityPlugin.validate_network_rbac_policy_change from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
  2016-06-27 21:52:30.128 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.plugins.ml2.plugin.Ml2Plugin.validate_network_rbac_policy_change from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
  2016-06-27 21:52:30.193 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.plugins.ml2.plugin.Ml2Plugin._process_ext_policy_create from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
  2016-06-27 21:52:30.193 DEBUG neutron.callbacks.manager [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] Calling callback neutron.objects.qos.policy.QosPolicy.validate_rbac_policy_change from (pid=31042) _notify_loop /opt/stack/neutron/neutron/callbacks/manager.py:147
  2016-06-27 21:52:30.196 ERROR oslo_db.sqlalchemy.exc_filters [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] DBAPIError exception wrapped from (pymysql.err.IntegrityError) (1048, u"Column 'target_tenant' cannot be null") [SQL: u'INSERT INTO networkrbacs (tenant_id, id, target_tenant, action, object_id) VALUES (%(tenant_id)s, %(id)s, %(target_tenant)s, %(action)s, %(object_id)s)'] [parameters: {'action': u'access_as_shared', 'tenant_id': u'aced7a29bb134dec82307a880d1cc542', 'target_tenant': None, 'id': '55a20046-d828-4307-bd4d-577b18d602f0', 'object_id': u'7946e91a-3879-4fcd-928e-66a99ed30112'}]
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters Traceback (most recent call last):
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1139, in _execute_context
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     context)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/default.py", line 450, in do_execute
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     cursor.execute(statement, parameters)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 161, in execute
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     result = self._query(query)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 317, in _query
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     conn.query(q)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 835, in query
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     self._affected_rows = self._read_query_result(unbuffered=unbuffered)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1019, in _read_query_result
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     result.read()
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1302, in read
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     first_packet = self.connection._read_packet()
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 981, in _read_packet
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     packet.check_error()
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 393, in check_error
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     err.raise_mysql_exception(self._data)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 120, in raise_mysql_exception
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     _check_mysql_exception(errinfo)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 112, in _check_mysql_exception
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters     raise errorclass(errno, errorvalue)
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters IntegrityError: (1048, u"Column 'target_tenant' cannot be null")
  2016-06-27 21:52:30.196 TRACE oslo_db.sqlalchemy.exc_filters 
  2016-06-27 21:52:30.232 ERROR neutron.api.v2.resource [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] create failed
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource Traceback (most recent call last):
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/resource.py", line 78, in resource
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     result = method(request=request, **args)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 409, in create
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return self._create(request, body, **kwargs)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_db/api.py", line 148, in wrapper
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     ectxt.value = e.inner_exc
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 221, in __exit__
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.force_reraise()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 197, in force_reraise
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     six.reraise(self.type_, self.value, self.tb)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_db/api.py", line 138, in wrapper
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return f(*args, **kwargs)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 521, in _create
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     obj = do_create(body)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 503, in do_create
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     request.context, reservation.reservation_id)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 221, in __exit__
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.force_reraise()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/oslo_utils/excutils.py", line 197, in force_reraise
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     six.reraise(self.type_, self.value, self.tb)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/api/v2/base.py", line 496, in do_create
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return obj_creator(request.context, **kwargs)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/opt/stack/neutron/neutron/db/rbac_db_mixin.py", line 52, in create_rbac_policy
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     context.session.add(db_entry)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 490, in __exit__
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.rollback()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/util/langhelpers.py", line 60, in __exit__
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     compat.reraise(exc_type, exc_value, exc_tb)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 487, in __exit__
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.commit()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 392, in commit
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self._prepare_impl()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 372, in _prepare_impl
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self.session.flush()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 2019, in flush
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self._flush(objects)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 2137, in _flush
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     transaction.rollback(_capture_exception=True)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/util/langhelpers.py", line 60, in __exit__
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     compat.reraise(exc_type, exc_value, exc_tb)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/session.py", line 2101, in _flush
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     flush_context.execute()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/unitofwork.py", line 373, in execute
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     rec.execute(self)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/unitofwork.py", line 532, in execute
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     uow
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/persistence.py", line 174, in save_obj
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     mapper, table, insert)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/orm/persistence.py", line 800, in _emit_insert_statements
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     execute(statement, params)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 914, in execute
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return meth(self, multiparams, params)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/sql/elements.py", line 323, in _execute_on_connection
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     return connection._execute_clauseelement(self, multiparams, params)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1010, in _execute_clauseelement
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     compiled_sql, distilled_params
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1146, in _execute_context
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     context)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1337, in _handle_dbapi_exception
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     util.raise_from_cause(newraise, exc_info)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/util/compat.py", line 202, in raise_from_cause
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     reraise(type(exception), exception, tb=exc_tb, cause=cause)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/base.py", line 1139, in _execute_context
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     context)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib64/python2.7/site-packages/sqlalchemy/engine/default.py", line 450, in do_execute
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     cursor.execute(statement, parameters)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 161, in execute
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     result = self._query(query)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/cursors.py", line 317, in _query
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     conn.query(q)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 835, in query
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     self._affected_rows = self._read_query_result(unbuffered=unbuffered)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1019, in _read_query_result
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     result.read()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 1302, in read
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     first_packet = self.connection._read_packet()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 981, in _read_packet
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     packet.check_error()
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/connections.py", line 393, in check_error
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     err.raise_mysql_exception(self._data)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 120, in raise_mysql_exception
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     _check_mysql_exception(errinfo)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource   File "/usr/lib/python2.7/site-packages/pymysql/err.py", line 112, in _check_mysql_exception
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource     raise errorclass(errno, errorvalue)
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource DBError: (pymysql.err.IntegrityError) (1048, u"Column 'target_tenant' cannot be null") [SQL: u'INSERT INTO networkrbacs (tenant_id, id, target_tenant, action, object_id) VALUES (%(tenant_id)s, %(id)s, %(target_tenant)s, %(action)s, %(object_id)s)'] [parameters: {'action': u'access_as_shared', 'tenant_id': u'aced7a29bb134dec82307a880d1cc542', 'target_tenant': None, 'id': '55a20046-d828-4307-bd4d-577b18d602f0', 'object_id': u'7946e91a-3879-4fcd-928e-66a99ed30112'}]
  2016-06-27 21:52:30.232 TRACE neutron.api.v2.resource 
  2016-06-27 21:52:30.239 INFO neutron.wsgi [req-b90fd6bf-2e7e-456e-9163-3c496e1ffac7 admin aced7a29bb134dec82307a880d1cc542] 192.168.1.176 - - [27/Jun/2016 21:52:30] "POST /v2.0/rbac-policies.json HTTP/1.1" 500 368 0.208457

                                                                                                                                              
  [detached from 11701.stack]
  bash-4.2$

To manage notifications about this bug go to:
https://bugs.launchpad.net/neutron/+bug/1596750/+subscriptions


Follow ups