Comment 2 for bug 1831100

Revision history for this message
Kris Watson (krisawatson) wrote :

Here is the stacktrace from the keystone.log file:

2019-05-31 07:15:11.225 116 INFO keystone.common.wsgi [req-04c098a1-b585-4e59-9a7e-bdebae4a5ab9 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] GET http://127.0.0.1:35357/v3/domains/lldap
2019-05-31 07:15:11.232 116 WARNING keystone.common.wsgi [req-04c098a1-b585-4e59-9a7e-bdebae4a5ab9 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] Could not find domain: lldap.: DomainNotFound: Could not find domain: lldap.
2019-05-31 07:15:11.368 116 INFO keystone.common.wsgi [req-0d588141-9949-499f-8d0d-dbe59c391d62 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] GET http://127.0.0.1:35357/v3/domains?name=lldap
2019-05-31 07:15:11.508 116 INFO keystone.common.wsgi [req-f6b5a271-ff8b-4f80-bde9-530d77989f04 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] GET http://127.0.0.1:35357/v3/groups/group2
2019-05-31 07:15:11.516 116 WARNING keystone.common.wsgi [req-f6b5a271-ff8b-4f80-bde9-530d77989f04 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] Could not find group: group2.: GroupNotFound: Could not find group: group2.
2019-05-31 07:15:11.622 116 INFO keystone.common.wsgi [req-57d94bc7-b8d4-4895-a21d-d348f48ab906 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] GET http://127.0.0.1:35357/v3/groups?domain_id=d2c019644a344302a9302bcf004fd3e3&name=group2
2019-05-31 07:15:11.623 116 WARNING py.warnings [req-57d94bc7-b8d4-4895-a21d-d348f48ab906 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] /usr/lib/python2.7/site-packages/oslo_policy/policy.py:869: UserWarning: Policy identity:list_groups failed scope check. The token used to make the request was project scoped but the policy requires ['system'] scope. This behavior may change in the future where using the intended scope is required
  warnings.warn(msg)

2019-05-31 07:15:11.790 116 INFO keystone.common.wsgi [req-9663b3c5-a9fa-4447-8cf9-ee537b2ffac8 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] GET http://127.0.0.1:35357/v3/groups/c6c5a4931e70af09259bcc2111ce569ea5cf386ceacfe485faa7a048873fb578/users?domain_id=d2c019644a344302a9302bcf004fd3e3
2019-05-31 07:15:11.809 116 WARNING py.warnings [req-9663b3c5-a9fa-4447-8cf9-ee537b2ffac8 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] /usr/lib/python2.7/site-packages/oslo_policy/policy.py:869: UserWarning: Policy identity:list_users_in_group failed scope check. The token used to make the request was project scoped but the policy requires ['system'] scope. This behavior may change in the future where using the intended scope is required
  warnings.warn(msg)

2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi [req-9663b3c5-a9fa-4447-8cf9-ee537b2ffac8 8442b4858f1b4bcc9438ed811c0a9d8c 134ee1ca088546b2b7c4591f75a7108d - default default] : DECODING_ERROR
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi Traceback (most recent call last):
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/common/wsgi.py", line 226, in __call__
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi result = method(req, **params)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/common/controller.py", line 126, in wrapper
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi return f(self, request, filters, **kwargs)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/identity/controllers.py", line 81, in list_users_in_group
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi group_id, hints=hints
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/common/manager.py", line 116, in wrapped
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi __ret_val = __f(*args, **kwargs)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/identity/core.py", line 416, in wrapper
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi return f(self, *args, **kwargs)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/identity/core.py", line 426, in wrapper
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi return f(self, *args, **kwargs)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/identity/core.py", line 1364, in list_users_in_group
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi ref_list = driver.list_users_in_group(entity_id, hints)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/identity/backends/ldap/core.py", line 129, in list_users_in_group
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi for user_id in self._transform_group_member_ids(group_members):
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/identity/backends/ldap/core.py", line 123, in _transform_group_member_ids
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi user_id = self.user._dn_to_id(user_key)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib/python2.7/site-packages/keystone/identity/backends/ldap/common.py", line 1286, in _dn_to_id
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi return utf8_decode(ldap.dn.str2dn(utf8_encode(dn))[0][0][1])
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib64/python2.7/site-packages/ldap/dn.py", line 53, in str2dn
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi return ldap.functions._ldap_function_call(None,_ldap.str2dn,dn,flags)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi File "/usr/lib64/python2.7/site-packages/ldap/functions.py", line 63, in _ldap_function_call
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi result = func(*args,**kwargs)
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi DECODING_ERROR
2019-05-31 07:15:11.812 116 ERROR keystone.common.wsgi
2019-05-31 07:15:14.865 117 INFO keystone.common.wsgi [req-36281b58-b8a0-40ce-aaa9-eb33ce162e64 - - - - -] GET http://10.1.246.155:5000/v2.0/
2019-05-31 07:15:24.859 117 INFO keystone.common.wsgi [req-0267cd28-d3c1-4a9d-b2d0-d9fcc37233b2 - - - - -] GET http://10.1.246.155:5000/v2.0/
2019-05-31 07:15:34.859 117 INFO keystone.common.wsgi [req-a74caf11-ac10-4b22-bd70-e48f9124edc5 - - - - -] GET http://10.1.246.155:5000/v2.0/