Uploaded image for project: 'Cache Modules'
  1. Cache Modules
  2. MGNLCACHE-199

Excessive cache flush due to wrong event pattern matching

XMLWordPrintable

    • Icon: Bug Bug
    • Resolution: Not an issue
    • Icon: Neutral Neutral
    • None
    • 5.6.1
    • cache core
    • None

      • After investigating into detail of cache flush - flush all policy extends from AbstractListeningFlushPolicy, we recognized that function 'info.magnolia.module.cache.AbstractListeningFlushPolicy.CacheCleaner.onEvent(EventIterator)' will trigger info.magnolia.module.cache.FlushAllListeningPolicy.preHandleEvents(Cache, String) on all most all events which leads to the whole cache flush multiple times.
      • Changing the filter from 
        if (!event.getPath().startsWith("/jcr:")) {
    eventList.add(event);
}

        to 

        if (event.getPath().lastIndexOf("/jcr:")==-1 && event.getPath().lastIndexOf("/mgnl:")==-1) {
    eventList.add(event);
}

        Could help alleviate the situation.

      • Please reference to attachment for a 'debug' version of cache flush policy which could print out all the events with its path for your information.
        Sample output: 
        2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/jcr:created
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/jcr:created
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/mgnl:lastModifiedBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/mgnl:created
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/mgnl:lastModifiedBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/jcr:uuid
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/mgnl:created
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/jcr:uuid
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/mgnl:lastModified
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/mgnl:lastModified
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/jcr:primaryType
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/mgnl:createdBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/jcr:primaryType
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/mgnl:createdBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/main/jcr:createdBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/main/jcr:createdBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 1 and path /test/aaaa/main
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 1 and path /test/aaaa/main
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 16 and path /test/aaaa/mgnl:lastModified
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 16 and path /test/aaaa/mgnl:lastModified
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 16 and path /test/aaaa/mgnl:lastModifiedBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 8 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 8 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 16 and path /test/aaaa/mgnl:lastModifiedBy
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 8 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,193 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/mgnl:lastModified
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 8 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/jcr:created
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/jcr:primaryType
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/mgnl:created
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/mgnl:lastModified
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/jcr:createdBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/jcr:created
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/jcr:uuid
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/jcr:primaryType
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/mgnl:lastModifiedBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/mgnl:created
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 4 and path /test/aaaa/footer/mgnl:createdBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 1 and path /test/aaaa/footer
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/jcr:createdBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 16 and path /test/aaaa/mgnl:lastModified
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/jcr:uuid
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 16 and path /test/aaaa/mgnl:lastModifiedBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/mgnl:lastModifiedBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 8 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache defaultPageCache in repository website which has event type 8 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 4 and path /test/aaaa/footer/mgnl:createdBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling pre-event cache defaultPageCache in repository website
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 1 and path /test/aaaa/footer
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 16 and path /test/aaaa/mgnl:lastModified
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 16 and path /test/aaaa/mgnl:lastModifiedBy
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 8 and path /test/aaaa/jcr:lockOwner
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling event cache uuid-key-mapping in repository website which has event type 8 and path /test/aaaa/jcr:lockIsDeep
2018-04-16 14:29:07,194 DEBUG .magnolia.module.cache.DefaultListeningFlushPolicy: Handling pre-event cache uuid-key-mapping in repository website

        Acceptance criteria

          1. DefaultListeningFlushPolicy.java
            11 kB

              Unassigned Unassigned
              viet.nguyen Viet Nguyen
              Votes:
              0 Vote for this issue
              Watchers:
              3 Start watching this issue

                Created:
                Updated:
                Resolved:

                  Bug DoR
                  Task DoD