bIT_sosswald
Returning Responder

Release über API führt zu warnings im Logfile - FS4.2

Hallo zusammen,

ich habe ein Modul, welches programmatisch über die API eine verschachtelte Struktur aus Ordnern und PageRefs (blauer Bereich) anlegt und diese dann am Ende entsprechend freigibt.

Das Release macht das Modul wie folgt:

Listable<PageRefFolder> childFolders = rootFolder.getChildren(PageRefFolder.class);

        for (PageRefFolder childFolder : childFolders) {

            Logging.logDebug("Start release PageRefFolder '" + childFolder.getReferenceName() + "'.", logger);

            childFolder.release(true);

            Logging.logDebug("End release PageRefFolder '" + childFolder.getReferenceName() + "'.", logger);

        }

rootFolder.release(false);

Dies wird so gemacht, da der RootFolder eine Startseite enthält, die redaktionell gepflegt wird, und somit nicht automatisiert vom Modul freugegeben werden soll. Daher holt sich das Modul alle direkten Kind-Ordner des Root-Folders und gibt diese dann rekursiv frei.

Nachdem der Release-Prozess gestartet wurde, bekomme ich massenhaft warnings, dass Referenzen nicht gefunden werden. (Siehe  folgenden Auszug aus dem  Logfile.)

DEBUG 06.02.2015 09:35:50.747 {pID=2883,uID=0,seID=5602} (com.XXX.structure.CatalogCreator): Start release PageRefFolder 'pagefolder:accessandsystems'.

DEBUG 06.02.2015 09:35:50.767 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRefFolder[396137]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.768 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRef[396139]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.768 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRef[396141]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.774 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRefFolder[396140]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.777 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRef[396138]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.907 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.storemanagement.StoreImpl): releasing [project=159110, element=396201, revision=772297]

DEBUG 06.02.2015 09:35:50.907 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.storage.ChildrenHandler): children changed (p=159110, file=de.espirit.storage.backend.FileImpl@9bf77{type=SITE_STORE_NODE_RELEASE_CHILDS, id=161650, revision=772297}) - new children size=8, oldChidren size=7

DEBUG 06.02.2015 09:35:50.908 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.storage.ChildrenHandler): children changed (p=159110, file=de.espirit.storage.backend.FileImpl@dc3ac{type=SITE_STORE_NODE_RELEASE_CHILDS, id=396201, revision=772297}) - new children size=7, oldChidren size=0

DEBUG 06.02.2015 09:35:50.908 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.storage.XmlHandler): xml changed (p=159110, file=de.espirit.storage.backend.FileImpl@dc31b{type=SITE_STORE_NODE_XML, id=396201, revision=772297}) - new =SITENODE{id=396201, editor=0, startnodeid=396202, releasedby=0, name=accessandsystems, releaseRevision=772297, meta=1}'

DEBUG 06.02.2015 09:35:50.908 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.storemanagement.StoreImpl): releaseElement project='159110' id=396201, revision=772297

WARN  06.02.2015 09:35:50.909 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): element not found: prj=159110, store=SITESTORE/R, id=396202, rev=772297

WARN  06.02.2015 09:35:50.909 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): couldn't update references for element of event StoreEvent[ELEMENT_INSERTED,prj=159110,id=396202,rev=772297,R]

WARN  06.02.2015 09:35:50.909 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): element not found: prj=159110, store=SITESTORE/R, id=396203, rev=772297

WARN  06.02.2015 09:35:50.909 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): couldn't update references for element of event StoreEvent[ELEMENT_INSERTED,prj=159110,id=396203,rev=772297,R]

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): element not found: prj=159110, store=SITESTORE/R, id=396268, rev=772297

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): couldn't update references for element of event StoreEvent[ELEMENT_INSERTED,prj=159110,id=396268,rev=772297,R]

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): element not found: prj=159110, store=SITESTORE/R, id=396279, rev=772297

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): couldn't update references for element of event StoreEvent[ELEMENT_INSERTED,prj=159110,id=396279,rev=772297,R]

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): element not found: prj=159110, store=SITESTORE/R, id=396296, rev=772297

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): couldn't update references for element of event StoreEvent[ELEMENT_INSERTED,prj=159110,id=396296,rev=772297,R]

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): element not found: prj=159110, store=SITESTORE/R, id=396379, rev=772297

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): couldn't update references for element of event StoreEvent[ELEMENT_INSERTED,prj=159110,id=396379,rev=772297,R]

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): element not found: prj=159110, store=SITESTORE/R, id=396396, rev=772297

WARN  06.02.2015 09:35:50.910 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.reference.ReferenceManagerImpl): couldn't update references for element of event StoreEvent[ELEMENT_INSERTED,prj=159110,id=396396,rev=772297,R]

DEBUG 06.02.2015 09:35:50.911 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.storemanagement.StoreImpl): releasing [project=159110, element=396202, revision=772297]

DEBUG 06.02.2015 09:35:50.911 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.storage.XmlHandler): xml changed (p=159110, file=de.espirit.storage.backend.FileImpl@dc318{type=SITE_STORE_NODE_XML, id=396202, revision=772297}) - new =PAGEREF{id=396202, editor=0, pageref=161656, releasedby=0, htmlname=accessandsystems, releaseRevision=772297, meta=1, uniquedescription=accessandsystems}'

DEBUG 06.02.2015 09:35:50.911 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.storemanagement.StoreImpl): releaseElement project='159110' id=396202, revision=772297

DEBUG 06.02.2015 09:35:50.911 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.store.access.DefaultStoreElement): refresh 396202, local revision 770729, dto revision 772297

DEBUG 06.02.2015 09:35:50.912 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.storage.ReferencesHandler): References changed (p=159110, file=de.espirit.storage.backend.FileImpl@dc3a6{type=REFS_OUTGOING_BY_ID (R$), id=396202, revision=772297}) - added: 3, deleted:0

DEBUG 06.02.2015 09:35:50.912 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.storemanagement.StoreImpl): releasing [project=159110, element=396203, revision=772297]

DEBUG 06.02.2015 09:35:50.913 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.storage.ChildrenHandler): children changed (p=159110, file=de.espirit.storage.backend.FileImpl@dc3ae{type=SITE_STORE_NODE_RELEASE_CHILDS, id=396203, revision=772297}) - new children size=6, oldChidren size=0

DEBUG 06.02.2015 09:35:50.923 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRefFolder[396160]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.946 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRefFolder[396163]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.958 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRef[396162]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.958 (de.espirit.firstspirit.server.search.store.StoreSourceIndex): document (prj=159110/PageRef[396161]) not indexed: de.espirit.firstspirit.server.search.IndexException: same or older revision => skip indexing

DEBUG 06.02.2015 09:35:50.959 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.storage.XmlHandler): xml changed (p=159110, file=de.espirit.storage.backend.FileImpl@dc319{type=SITE_STORE_NODE_XML, id=396203, revision=772297}) - new =SITENODE{id=396203, editor=0, startnodeid=396204, releasedby=0, name=buildingintegrationsystem, releaseRevision=772297, meta=1}'

DEBUG 06.02.2015 09:35:50.959 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.server.storemanagement.StoreImpl): releaseElement project='159110' id=396203, revision=772297

DEBUG 06.02.2015 09:35:50.959 {pID=2883,uID=0,seID=5602} (de.espirit.firstspirit.store.access.DefaultStoreElement): refresh 396203, local revision 770872, dto revision 772297

Der Releaseprozess selbst, funktioniert aber ohne Probleme und auch das Ergebnis in FirstSpirit ist absolut in Ordnung.

Jedoch sehen die Warnings im Logfile und in der Übersicht des entsprechenden Schedules natürlich nicht so schön aus.

Kann mir jemand sagen, wie diese Warnings verhindert werden können?

Besten Dank bereits jetzt.

Sandro

Labels (1)
0 Kudos
2 Replies
MichaelaReydt
Community Manager
Community Manager

Re: Release über API führt zu warnings im Logfile - FS4.2

Hallo Sandro,

was auffällt sind die zahlreichen "Element not found"-Meldungen. Weißt du, um was für Elemente es sich bei den in der Meldung genannten handelt? Beispielsweise das mit der id 396379?

Viele Grüße

Michaela

0 Kudos
bIT_sosswald
Returning Responder

Re: Release über API führt zu warnings im Logfile - FS4.2

Hallo Michaela,

ich habe parallel zu diesem Thema auch ein Ticket beim helpdesk offen. (#16264)

Hier ein Auszug aus der aktuellsten Antwort dazu:

>1. Massenhafte WARNING Log-Meldungen nach einem Aufruf von "childFolder.release(true); " (Oberer Teil des Tickets)

Punkt 1 ist laut unserer Fehler-Datenbank ein bekanntes Problem (ID: 114610), dass erst ab 5.0 behoben wurde.
Ein Backmerge des Fixes nach 4.2 ist nicht geplant.

Es scheint sich also um ein bekanntes Problem zu handeln. (Siehe #114610 in der e-Spirit Fehlerdatenbank)

"Element not found"-Meldungen müssten sich alle auf die über das Modul bzw. den Service im modul angelegten und gespeicherten Struktur-Elemente bezihen (Ordner und PageRefs), die freigegeben werden sollen.

Grüße

Sandro

0 Kudos