[CMS-9890] Publishing a page requires to reindex to see the contents under sub pages in the search engine

Type: Bug
Resolution: Cannot Reproduce
Priority: Major
Fix Version/s: 4.2.12, 4.3.0
Affects Version/s: None
Component/s: Plugin : Search
Labels:
None

Sprint:
4.3 RC2

How to reproduce

Insert into a page the new search engine service
Insert the following parameters :
- Requested elements : contents
- Types of content: news, article
- Critéres : (commun>texte intégral correspond à une valeur entrée par le visiteur et Contenus>Tous>Orphelin égale la valeur Non)
Create a main topic page with a template with content without validating it
Create a sub page with article content and validate this content
Create a new sub page with article content and validate this content
Take a live test to find the content
ok, we can not find the contents
Validate the content of the main section
Take another live test

The contents of the sub pages are not displayed, we are obliged to index for the content back in the search engine

Simon Prieul (Inactive) added a comment - 17/Mar/20 18:10

Seen with afrancois, we cannot reproduce

Simon Prieul (Inactive) added a comment - 17/Mar/20 18:10 Seen with afrancois , we cannot reproduce

Simon Prieul (Inactive) added a comment - 16/Mar/20 15:34

I cannot reproduce in 4.3.0

Here are of the logs that demonstrates that the 3 pages and the 3 contents are redindexed :

2020-03-16 13:57:27,900 INFO  [org.ametys.web.workflow.ValidateContentFunction] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Performing content validation
2020-03-16 13:57:27,904 INFO  [org.ametys.cms.observation.AllEvents] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Receiving event[id: content.workflow.changed, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]]
2020-03-16 13:57:27,905 INFO  [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.cms.content.indexing.solr.observation.IndexContentObserver@4cfb941c for event: event[id: content.workflow.changed, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]]
2020-03-16 13:57:27,920 INFO  [org.ametys.cms.observation.AllEvents] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Receiving event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]]

2020-03-16 13:57:27,977 INFO  [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.web.indexing.observation.SolrLiveContentValidatedOrTaggedObserver@4a119fa4 for event: event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]]
2020-03-16 13:57:27,978 INFO  [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.plugins.userdirectory.observation.SolrContentValidatedObserver@4fcfd4c7 for event: event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]]
2020-03-16 13:57:27,980 INFO  [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.web.indexing.observation.SolrContentValidatedObserver@6f672dca for event: event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]]
2020-03-16 13:57:27,986 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing content defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23 into Solr for workspace live
2020-03-16 13:57:28,012 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successfully indexed content defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23 in Solr in 26 ms
2020-03-16 13:57:28,013 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Reindexing page: page://9b96b499-e3f1-4ecf-b614-e91803d84890
2020-03-16 13:57:28,013 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Unindexing page page://9b96b499-e3f1-4ecf-b614-e91803d84890 in workspace 'default'
2020-03-16 13:57:28,036 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page de-indexing with its children. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890
2020-03-16 13:57:28,036 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content' (page://9b96b499-e3f1-4ecf-b614-e91803d84890) in workspace 'default'
2020-03-16 13:57:28,038 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890
2020-03-16 13:57:28,038 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/sub-page-with-validated-article' (page://96615110-f190-4477-9141-16687affc5ef) in workspace 'default'
2020-03-16 13:57:28,040 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://96615110-f190-4477-9141-16687affc5ef
2020-03-16 13:57:28,040 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/new-sub-page-with-validated-article' (page://742976eb-ac18-44cc-9dc6-64bc708e52e4) in workspace 'default'
2020-03-16 13:57:28,041 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://742976eb-ac18-44cc-9dc6-64bc708e52e4

2020-03-16 13:57:28,041 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Reindexing page: page://9b96b499-e3f1-4ecf-b614-e91803d84890
2020-03-16 13:57:28,041 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Unindexing page page://9b96b499-e3f1-4ecf-b614-e91803d84890 in workspace 'live'
2020-03-16 13:57:28,139 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page de-indexing with its children. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890
2020-03-16 13:57:28,139 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content' (page://9b96b499-e3f1-4ecf-b614-e91803d84890) in workspace 'live'
2020-03-16 13:57:28,141 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890
2020-03-16 13:57:28,142 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/sub-page-with-validated-article' (page://96615110-f190-4477-9141-16687affc5ef) in workspace 'live'
2020-03-16 13:57:28,143 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://96615110-f190-4477-9141-16687affc5ef
2020-03-16 13:57:28,143 INFO  [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/new-sub-page-with-validated-article' (page://742976eb-ac18-44cc-9dc6-64bc708e52e4) in workspace 'live'
2020-03-16 13:57:28,146 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://742976eb-ac18-44cc-9dc6-64bc708e52e4

What's more, reading the code seems fine too:

SolrContentValidatedObserver#observe calls #_updateIndexReferencingPages with true for 'recursively'

which gets the referencing pages, and reindexed the pages recursively in DEFAULT and LIVE workspaces

Simon Prieul (Inactive) added a comment - 16/Mar/20 15:34 I cannot reproduce in 4.3.0 Here are of the logs that demonstrates that the 3 pages and the 3 contents are redindexed : 2020-03-16 13:57:27,900 INFO [org.ametys.web.workflow.ValidateContentFunction] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Performing content validation 2020-03-16 13:57:27,904 INFO [org.ametys.cms.observation.AllEvents] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Receiving event[id: content.workflow.changed, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]] 2020-03-16 13:57:27,905 INFO [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.cms.content.indexing.solr.observation.IndexContentObserver@4cfb941c for event: event[id: content.workflow.changed, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]] 2020-03-16 13:57:27,920 INFO [org.ametys.cms.observation.AllEvents] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Receiving event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]] 2020-03-16 13:57:27,977 INFO [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.web.indexing.observation.SolrLiveContentValidatedOrTaggedObserver@4a119fa4 for event: event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]] 2020-03-16 13:57:27,978 INFO [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.plugins.userdirectory.observation.SolrContentValidatedObserver@4fcfd4c7 for event: event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]] 2020-03-16 13:57:27,980 INFO [org.ametys.core.observation.ObservationManager] (http-nio-10000-exec-8;/cms/plugins/core-ui/servercomm/messages.xml) Notifying observer: org.ametys.web.indexing.observation.SolrContentValidatedObserver@6f672dca for event: event[id: content.validated, issuer: UserIdentity [login=sprieul, population=users], args: [content.id = defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23, content = '/ametys-internal:sites/www/ametys-internal:contents/nouveau-contenu-de-developpement-17' (defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23)]] 2020-03-16 13:57:27,986 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing content defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23 into Solr for workspace live 2020-03-16 13:57:28,012 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successfully indexed content defaultWebContent://5258f088-486a-43c7-9558-122417cc2f23 in Solr in 26 ms 2020-03-16 13:57:28,013 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Reindexing page: page://9b96b499-e3f1-4ecf-b614-e91803d84890 2020-03-16 13:57:28,013 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Unindexing page page://9b96b499-e3f1-4ecf-b614-e91803d84890 in workspace 'default' 2020-03-16 13:57:28,036 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page de-indexing with its children. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890 2020-03-16 13:57:28,036 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content' (page://9b96b499-e3f1-4ecf-b614-e91803d84890) in workspace 'default' 2020-03-16 13:57:28,038 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890 2020-03-16 13:57:28,038 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/sub-page-with-validated-article' (page://96615110-f190-4477-9141-16687affc5ef) in workspace 'default' 2020-03-16 13:57:28,040 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://96615110-f190-4477-9141-16687affc5ef 2020-03-16 13:57:28,040 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/new-sub-page-with-validated-article' (page://742976eb-ac18-44cc-9dc6-64bc708e52e4) in workspace 'default' 2020-03-16 13:57:28,041 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://742976eb-ac18-44cc-9dc6-64bc708e52e4 2020-03-16 13:57:28,041 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Reindexing page: page://9b96b499-e3f1-4ecf-b614-e91803d84890 2020-03-16 13:57:28,041 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Unindexing page page://9b96b499-e3f1-4ecf-b614-e91803d84890 in workspace 'live' 2020-03-16 13:57:28,139 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page de-indexing with its children. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890 2020-03-16 13:57:28,139 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content' (page://9b96b499-e3f1-4ecf-b614-e91803d84890) in workspace 'live' 2020-03-16 13:57:28,141 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://9b96b499-e3f1-4ecf-b614-e91803d84890 2020-03-16 13:57:28,142 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/sub-page-with-validated-article' (page://96615110-f190-4477-9141-16687affc5ef) in workspace 'live' 2020-03-16 13:57:28,143 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://96615110-f190-4477-9141-16687affc5ef 2020-03-16 13:57:28,143 INFO [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Indexing page: '/ametys-internal:sites/www/ametys-internal:sitemaps/fr/rc1-bugfixes/cms-9890/main-topic-page-with-unvalidated-content/new-sub-page-with-validated-article' (page://742976eb-ac18-44cc-9dc6-64bc708e52e4) in workspace 'live' 2020-03-16 13:57:28,146 DEBUG [org.ametys.cms.content.indexing.solr.SolrIndexer] (ametys-async-observe-10;/cms/plugins/core-ui/servercomm/messages.xml) Successful page indexing. Page identifier : page://742976eb-ac18-44cc-9dc6-64bc708e52e4 What's more, reading the code seems fine too: SolrContentValidatedObserver#observe calls #_updateIndexReferencingPages with true for 'recursively' which gets the referencing pages, and reindexed the pages recursively in DEFAULT and LIVE workspaces

Details

Description

Attachments

Activity

Collapse comment: Simon Prieul (Inactive) added a comment - 17/Mar/20 18:10

Expand comment: Simon Prieul (Inactive) added a comment - 17/Mar/20 18:10

Collapse comment: Simon Prieul (Inactive) added a comment - 16/Mar/20 15:34

Expand comment: Simon Prieul (Inactive) added a comment - 16/Mar/20 15:34

People

Dates

Contact Product Support