View Issue Details

IDProjectCategoryView StatusLast Update
0000644Pgpool-IIEnhancementpublic2020-08-29 10:11
Reporteraarevalo Assigned Tot-ishii  
PrioritynormalSeveritytweakReproducibilityalways
Status feedbackResolutionopen 
Product Version4.1.3 
Summary0000644: Log spam when using shared memory cache
DescriptionWe run a busy instance of PgPool (400 processes handling +40k queries/second). We use shared memory cache.
There's a log message appearing constantly:

Aug 28 13:16:43 pgpool03 pgpool[8203]: [52-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 276 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [53-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 277 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [54-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 278 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [55-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 279 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [56-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 280 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [57-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 281 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [58-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 282 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [59-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 271 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [60-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 272 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [61-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 273 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [62-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 273 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [63-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 274 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [64-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 275 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [65-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 276 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [66-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 276 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [67-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 277 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [68-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 278 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [69-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 279 was already deleted
Aug 28 13:16:43 pgpool03 pgpool[8203]: [70-1] 2020-08-28 13:16:43: pid 8203: LOG: error while deleting item from shmem cache, item: 279 was already deleted

After taking a look at the source code, it seems that's not an error but a warning or debug one.

This prevents us from enabling logging in this instance as the message repeats thousands of times per second.
TagsNo tags attached.

Activities

t-ishii

2020-08-29 10:10

developer   ~0003530

> After taking a look at the source code, it seems that's not an error but a warning or debug one.
Yes, the cache item to be deleted is fetched from file called "oid" files. For a performance reason, it is possible that the file includes duplicate cache items. I think we can safely downgrade the "WARNING" to DEBUG5 or so.

Issue History

Date Modified Username Field Change
2020-08-28 20:53 aarevalo New Issue
2020-08-29 10:10 t-ishii Note Added: 0003530
2020-08-29 10:11 t-ishii Assigned To => t-ishii
2020-08-29 10:11 t-ishii Status new => feedback