Bug #5062: Real time module sometimes gracefully exits - Mentat - Homeproj: Redmine for CESNET

Actions

Copy link

Bug #5062

closed

Real time module sometimes gracefully exits

Added by Pavel Kácha over 5 years ago. Updated about 5 years ago.

Status:

Closed

Priority:

Normal

Assignee:

Jan Žerdík

Category:

Development - Core

Target version:

2.5

Start date:

05/13/2019

Due date:

% Done:

100%

Estimated time:

To be discussed:

Description

Enricher sometimes exits gracerully without error. Related log message is:

2019-03-26 08:05:45,826 mentat-inspector.py [53163] INFO: Daemon processing termination forced by empty queue, will not wait for time scheduled events.

Maybe flawed one-shot handling?

Actions

Copy link

Updated by Pavel Kácha over 5 years ago

Target version changed from 2.5 to 2.6

Actions

Copy link

Updated by Pavel Kácha over 5 years ago

Subject changed from Enricher sometimes gracefully exits to Inspector sometimes gracefully exits

Happened again in mentat-inspector-b.py on mentat-hub. Related log excerpt:

2019-07-22 18:13:23,839 mentat-inspector-b.py [45553] INFO: Waiting for '2' seconds until next scheduled event
2019-07-22 18:13:25,840 mentat-inspector-b.py [45553] INFO: Received wakeup signal (14)
2019-07-22 18:13:25,962 mentat-inspector-b.py [45553] INFO: Component 'filer': Scheduling next queue check after '3' seconds
2019-07-22 18:13:25,962 mentat-inspector-b.py [45553] INFO: Waiting for '1' seconds until next scheduled event
2019-07-22 18:13:26,962 mentat-inspector-b.py [45553] INFO: Received wakeup signal (14)
2019-07-22 18:13:26,962 mentat-inspector-b.py [45553] INFO: Waiting for '2' seconds until next scheduled event
2019-07-22 18:13:28,962 mentat-inspector-b.py [45553] INFO: Received wakeup signal (14)
2019-07-22 18:13:28,963 mentat-inspector-b.py [45553] INFO: Component 'filer': Scheduling next queue check after '3' seconds
2019-07-22 18:13:28,963 mentat-inspector-b.py [45553] INFO: Waiting for '1' seconds until next scheduled event
2019-07-22 18:13:29,963 mentat-inspector-b.py [45553] INFO: Received wakeup signal (14)
2019-07-22 18:13:29,963 mentat-inspector-b.py [45553] INFO: Daemon processing termination forced by empty queue, will not wait for time scheduled events.
2019-07-22 18:13:29,964 mentat-inspector-b.py [45553] INFO: Application runtime: '11 days, 9:20:32.580250' (effectivity 100.00 %)

Actions

Copy link

Updated by Pavel Kácha over 5 years ago

Subject changed from Inspector sometimes gracefully exits to Real time module sometimes gracefully exits

Now observed on enricher (luckily we have more instances):

2019-07-25 02:50:24,016 mentat-enricher.py [45532] INFO: Daemon processing termination forced by empty queue, will not wait for time schedule
d events.

Actions

Copy link

Updated by Jan Žerdík about 5 years ago

Status changed from New to Resolved
Assignee changed from Jan Mach to Jan Žerdík
Target version changed from 2.6 to 2.5
% Done changed from 0 to 100

When two scheduled events is planed close to each other and one should have started during progress of the other, the method wait on EventQueueManager returns negative number (return self.events_at[0][0] - time.time()). It was tested against zero, better is testing explicitly size of the queue (method count).

[[https://github.com/honzamach/pyzenkit/pull/1]]

Actions

Copy link