Re: [openstack-dev] [Barbican] Keystone Listener error when processing delete project event

2018-02-16 Thread Lance Bragstad 
Taking a quick look at the barbican code, it might be that something isn't
setting up the _SESSION_FACTORY [0], but I'm certainly not a barbican
expert. Might be worth while to open a bug [1].

[0]
https://github.com/openstack/barbican/blob/5b525f6b0a7cf5342a9ffa3ca3618028d6d53649/barbican/model/repositories.py#L95-L113
[1] https://bugs.launchpad.net/barbican

On Fri, Feb 16, 2018 at 9:40 AM,  wrote:

> Hello,
>
>
>
>
>
> The Keystone Listener outputs the below error, over and over again, when
> processing a delete project event. Do you have any idea why this happens?
> Happens the same with Ocata and Pike versions.
>
>
>
> Thank you,
>
> Mihaela Balas
>
>
>
> 2018-02-16 15:36:02.673 1 DEBUG amqp [-] heartbeat_tick : for connection
> ef42486446c34306bd10921b264da26b heartbeat_tick
> /opt/barbican/lib/python2.7/site-packages/amqp/connection.py:678
>
> 2018-02-16 15:36:02.673 1 DEBUG amqp [-] heartbeat_tick : Prev sent/recv:
> 111624/334860, now - 111625/334860, monotonic - 895085.445269,
> last_heartbeat_sent - 895085.445263, heartbeat int. - 60 for connection
> ef42486446c34306bd10921b264da26b heartbeat_tick
> /opt/barbican/lib/python2.7/site-packages/amqp/connection.py:700
>
> 2018-02-16 15:36:02.675 1 DEBUG oslo_messaging._drivers.amqpdriver [-]
> received message with unique_id: 0a407a9a71b641c888c49c0d4674b607
> __call__ /opt/barbican/lib/python2.7/site-packages/oslo_messaging/_
> drivers/amqpdriver.py:257
>
> 2018-02-16 15:36:02.675 1 DEBUG amqp [-] heartbeat_tick : for connection
> ef42486446c34306bd10921b264da26b heartbeat_tick
> /opt/barbican/lib/python2.7/site-packages/amqp/connection.py:678
>
> 2018-02-16 15:36:02.675 1 DEBUG amqp [-] heartbeat_tick : Prev sent/recv:
> 111625/334860, now - 111625/334863, monotonic - 895085.447218,
> last_heartbeat_sent - 895085.445263, heartbeat int. - 60 for connection
> ef42486446c34306bd10921b264da26b heartbeat_tick
> /opt/barbican/lib/python2.7/site-packages/amqp/connection.py:700
>
> 2018-02-16 15:36:02.676 1 DEBUG barbican.queue.keystone_listener [-]
> Input keystone event publisher_id = 
> identity.keystone-admin-api-2903979735-fsj57
> process_event /opt/barbican/lib/python2.7/site-packages/barbican/queue/
> keystone_listener.py:72
>
> 2018-02-16 15:36:02.676 1 DEBUG barbican.queue.keystone_listener [-]
> Input keystone event payload = {u'resource_info': u'
> 79d3491d58e542ada54776d2bd68ef7e'} process_event
> /opt/barbican/lib/python2.7/site-packages/barbican/queue/
> keystone_listener.py:73
>
> 2018-02-16 15:36:02.676 1 DEBUG barbican.queue.keystone_listener [-]
> Input keystone event type = identity.project.deleted process_event
> /opt/barbican/lib/python2.7/site-packages/barbican/queue/
> keystone_listener.py:74
>
> 2018-02-16 15:36:02.677 1 DEBUG barbican.queue.keystone_listener [-]
> Input keystone event metadata = {'timestamp': u'2018-02-16
> 15:35:48.506374', 'message_id': u'5cc2ef82-75a7-4ce9-a9eb-573ae008f4e4'}
> process_event /opt/barbican/lib/python2.7/site-packages/barbican/queue/
> keystone_listener.py:75
>
> 2018-02-16 15:36:02.677 1 DEBUG barbican.queue.keystone_listener [-]
> Keystone Event: resource type=project, operation type=deleted, keystone id=
> 79d3491d58e542ada54776d2bd68ef7e process_event
> /opt/barbican/lib/python2.7/site-packages/barbican/queue/
> keystone_listener.py:80
>
> 2018-02-16 15:36:02.677 1 DEBUG barbican.tasks.keystone_consumer [-]
> Creating KeystoneEventConsumer task processor __init__
> /opt/barbican/lib/python2.7/site-packages/barbican/tasks/
> keystone_consumer.py:40
>
> 2018-02-16 15:36:02.677 1 DEBUG barbican.model.repositories [-] Getting
> session... get_session /opt/barbican/lib/python2.7/
> site-packages/barbican/model/repositories.py:353
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources [-] Could not
> retrieve information needed to process task 'Project cleanup via Keystone
> notifications'.: TypeError: 'NoneType' object is not callable
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources Traceback (most
> recent call last):
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File
> "/opt/barbican/lib/python2.7/site-packages/barbican/tasks/resources.py",
> line 91, in process
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources entity =
> self.retrieve_entity(*args, **kwargs)
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File
> "/opt/barbican/lib/python2.7/site-packages/barbican/tasks/keystone_consumer.py",
> line 67, in retrieve_entity
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources
> suppress_exception=True)
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File
> "/opt/barbican/lib/python2.7/site-packages/barbican/model/repositories.py",
> line 586, in find_by_external_project_id
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources session =
> self.get_session(session)
>
> 2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File
>

[openstack-dev] [Barbican] Keystone Listener error when processing delete project event

2018-02-16 Thread mihaela.balas 
Hello,


The Keystone Listener outputs the below error, over and over again, when 
processing a delete project event. Do you have any idea why this happens? 
Happens the same with Ocata and Pike versions.

Thank you,
Mihaela Balas

2018-02-16 15:36:02.673 1 DEBUG amqp [-] heartbeat_tick : for connection 
ef42486446c34306bd10921b264da26b heartbeat_tick 
/opt/barbican/lib/python2.7/site-packages/amqp/connection.py:678
2018-02-16 15:36:02.673 1 DEBUG amqp [-] heartbeat_tick : Prev sent/recv: 
111624/334860, now - 111625/334860, monotonic - 895085.445269, 
last_heartbeat_sent - 895085.445263, heartbeat int. - 60 for connection 
ef42486446c34306bd10921b264da26b heartbeat_tick 
/opt/barbican/lib/python2.7/site-packages/amqp/connection.py:700
2018-02-16 15:36:02.675 1 DEBUG oslo_messaging._drivers.amqpdriver [-] received 
message with unique_id: 0a407a9a71b641c888c49c0d4674b607 __call__ 
/opt/barbican/lib/python2.7/site-packages/oslo_messaging/_drivers/amqpdriver.py:257
2018-02-16 15:36:02.675 1 DEBUG amqp [-] heartbeat_tick : for connection 
ef42486446c34306bd10921b264da26b heartbeat_tick 
/opt/barbican/lib/python2.7/site-packages/amqp/connection.py:678
2018-02-16 15:36:02.675 1 DEBUG amqp [-] heartbeat_tick : Prev sent/recv: 
111625/334860, now - 111625/334863, monotonic - 895085.447218, 
last_heartbeat_sent - 895085.445263, heartbeat int. - 60 for connection 
ef42486446c34306bd10921b264da26b heartbeat_tick 
/opt/barbican/lib/python2.7/site-packages/amqp/connection.py:700
2018-02-16 15:36:02.676 1 DEBUG barbican.queue.keystone_listener [-] Input 
keystone event publisher_id = identity.keystone-admin-api-2903979735-fsj57 
process_event 
/opt/barbican/lib/python2.7/site-packages/barbican/queue/keystone_listener.py:72
2018-02-16 15:36:02.676 1 DEBUG barbican.queue.keystone_listener [-] Input 
keystone event payload = {u'resource_info': 
u'79d3491d58e542ada54776d2bd68ef7e'} process_event 
/opt/barbican/lib/python2.7/site-packages/barbican/queue/keystone_listener.py:73
2018-02-16 15:36:02.676 1 DEBUG barbican.queue.keystone_listener [-] Input 
keystone event type = identity.project.deleted process_event 
/opt/barbican/lib/python2.7/site-packages/barbican/queue/keystone_listener.py:74
2018-02-16 15:36:02.677 1 DEBUG barbican.queue.keystone_listener [-] Input 
keystone event metadata = {'timestamp': u'2018-02-16 15:35:48.506374', 
'message_id': u'5cc2ef82-75a7-4ce9-a9eb-573ae008f4e4'} process_event 
/opt/barbican/lib/python2.7/site-packages/barbican/queue/keystone_listener.py:75
2018-02-16 15:36:02.677 1 DEBUG barbican.queue.keystone_listener [-] Keystone 
Event: resource type=project, operation type=deleted, keystone 
id=79d3491d58e542ada54776d2bd68ef7e process_event 
/opt/barbican/lib/python2.7/site-packages/barbican/queue/keystone_listener.py:80
2018-02-16 15:36:02.677 1 DEBUG barbican.tasks.keystone_consumer [-] Creating 
KeystoneEventConsumer task processor __init__ 
/opt/barbican/lib/python2.7/site-packages/barbican/tasks/keystone_consumer.py:40
2018-02-16 15:36:02.677 1 DEBUG barbican.model.repositories [-] Getting 
session... get_session 
/opt/barbican/lib/python2.7/site-packages/barbican/model/repositories.py:353
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources [-] Could not retrieve 
information needed to process task 'Project cleanup via Keystone 
notifications'.: TypeError: 'NoneType' object is not callable
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources Traceback (most recent 
call last):
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File 
"/opt/barbican/lib/python2.7/site-packages/barbican/tasks/resources.py", line 
91, in process
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources entity = 
self.retrieve_entity(*args, **kwargs)
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File 
"/opt/barbican/lib/python2.7/site-packages/barbican/tasks/keystone_consumer.py",
 line 67, in retrieve_entity
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources 
suppress_exception=True)
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File 
"/opt/barbican/lib/python2.7/site-packages/barbican/model/repositories.py", 
line 586, in find_by_external_project_id
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources session = 
self.get_session(session)
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File 
"/opt/barbican/lib/python2.7/site-packages/barbican/model/repositories.py", 
line 354, in get_session
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources return session or 
get_session()
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources   File 
"/opt/barbican/lib/python2.7/site-packages/barbican/model/repositories.py", 
line 161, in get_session
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources return 
_SESSION_FACTORY()
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources TypeError: 'NoneType' 
object is not callable
2018-02-16 15:36:02.677 1 ERROR barbican.tasks.resources
2018-02-16 15:36:02.678 1 DEBUG