jhorsman
5/7/2015 - 1:38 PM
SI4T log for publishing the same page twice after starting the deployer webapp. Here you clearly see what is logged when the deployer webapp
SI4T log for publishing the same page twice after starting the deployer webapp. Here you clearly see what is logged when the deployer webapp initlializes (triggered by the first transaction) and what is logged during publishing. The "DEBUG LoggerIndexer" messages are written by https://github.com/jhorsman/si4t-logger-searchindex
2015-05-07 15:11:29,842 INFO SearchIndexProcessor - Configuration is: Storage(Class=com.tridion.storage.si4t.JPASearchDAOFactory, Id=defaultdb, Type=persistence, dialect=MSSQL)[Pool(CheckoutTimeout=120, IdleTimeout=120, MonitorInterval=60, Size=10, Type=jdbc), DataSource(Class=com.microsoft.sqlserver.jdbc.SQLServerDataSource)[Property(Name=serverName, Value=localhost), Property(Name=portNumber, Value=1433), Property(Name=databaseName, Value=Tridion_Broker), Property(Name=user, Value=TridionBrokerUser), Property(Name=password, Value=Tr1d10n2015)], Indexer(Class=org.si4t.logger.LoggerIndexer, DefaultCoreUrl=http://localhost, DocExtensions=pdf,docx,doc,xls,xlsx,pptx,ppt, Mode=http)]
2015-05-07 15:11:29,844 INFO SearchIndexProcessor - Using: org.si4t.logger.LoggerIndexer as search index class for storageId: defaultdb
2015-05-07 15:11:29,844 INFO SearchIndexProcessor - Loading org.si4t.logger.LoggerIndexer
2015-05-07 15:11:29,850 DEBUG LoggerIndexer - cofigure() called
2015-05-07 15:11:29,851 DEBUG LoggerIndexer - Configuration is: Storage(Class=com.tridion.storage.si4t.JPASearchDAOFactory, Id=defaultdb, Type=persistence, dialect=MSSQL)[Pool(CheckoutTimeout=120, IdleTimeout=120, MonitorInterval=60, Size=10, Type=jdbc), DataSource(Class=com.microsoft.sqlserver.jdbc.SQLServerDataSource)[Property(Name=serverName, Value=localhost), Property(Name=portNumber, Value=1433), Property(Name=databaseName, Value=Tridion_Broker), Property(Name=user, Value=TridionBrokerUser), Property(Name=password, Value=Tr1d10n2015)], Indexer(Class=org.si4t.logger.LoggerIndexer, DefaultCoreUrl=http://localhost, DocExtensions=pdf,docx,doc,xls,xlsx,pptx,ppt, Mode=http)]
2015-05-07 15:11:29,851 INFO SearchIndexProcessor - Configured: org.si4t.logger.LoggerIndexer
2015-05-07 15:11:29,851 INFO SearchIndexProcessor - Loaded: org.si4t.logger.LoggerIndexer
2015-05-07 15:11:37,928 DEBUG JPASearchComponentPresentationDAO - JPASearchComponentPresentationDAO Init.
2015-05-07 15:11:38,034 DEBUG JPASearchPageDAO - JPASearchPageDAO init.
2015-05-07 15:11:40,406 DEBUG JPASearchPageDAO - JPASearchPageDAO init. (EM)
2015-05-07 15:11:40,531 DEBUG JPASearchPageDAO - Update. Orgpath=/articles/news/news1.html
2015-05-07 15:11:40,539 INFO TridionPublishableItemProcessor - Finding search directives.
2015-05-07 15:11:40,543 DEBUG TridionPublishableItemProcessor - Search Directive string: <indexdata><url>/articles/news/news1.html</url><title>Planes</title><publicationid>4</publicationid><schemaid>110</schemaid><itemtype>64</itemtype><parentsgid>65</parentsgid><sgid>65</sgid><sgid>64</sgid><sgid>12</sgid><type>0</type><body>Sed dapibus tempus nunc, id sollicitudin ligula mattis in. Cras vel justo semper, bibendum odio in, fringilla elit. Cras at nunc fringilla, porttitor mauris eget, pharetra purus. Sed elementum consectetur massa id auctor. Mauris sed orci nec diam condimentum fermentum id eget erat. Nulla facilisi. In venenatis mauris dolor, iaculis lobortis libero porttitor sit amet. Aliquam quis egestas turpis. Morbi dolor nulla, volutpat ut nisi sed, mollis lacinia sapien.. Praesent facilisis consectetur neque. Cras vel justo semp. Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id. </body><custom><summary>Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id</summary></custom></indexdata>
2015-05-07 15:11:40,547 INFO TridionPublishableItemProcessor - Registering tcm:4-309-64, for: UPDATE
2015-05-07 15:11:41,158 DEBUG JPASearchBinaryContentDAO - Configuration: Storage(Class=com.tridion.storage.si4t.JPASearchDAOFactory, Id=defaultdb, Type=persistence, dialect=MSSQL)[Pool(CheckoutTimeout=120, IdleTimeout=120, MonitorInterval=60, Size=10, Type=jdbc), DataSource(Class=com.microsoft.sqlserver.jdbc.SQLServerDataSource)[Property(Name=serverName, Value=localhost), Property(Name=portNumber, Value=1433), Property(Name=databaseName, Value=Tridion_Broker), Property(Name=user, Value=TridionBrokerUser), Property(Name=password, Value=Tr1d10n2015)], Indexer(Class=org.si4t.logger.LoggerIndexer, DefaultCoreUrl=http://localhost, DocExtensions=pdf,docx,doc,xls,xlsx,pptx,ppt, Mode=http)]
2015-05-07 15:11:41,218 INFO JPASearchBinaryContentDAO - Checking update for: /media/planes_tcm4-253.jpg
2015-05-07 15:11:41,451 INFO JPASearchDAOFactory - Start committing transaction: tcm:0-9071-66560
2015-05-07 15:11:41,463 DEBUG JPASearchDAOFactory - Commit Indexing Start
2015-05-07 15:11:41,463 INFO SearchIndexProcessor - Triggering Indexing for transaction: tcm:0-9071-66560
2015-05-07 15:11:41,464 DEBUG SearchIndexProcessor - Obtaining SearchIndex class for: defaultdb
2015-05-07 15:11:41,464 DEBUG SearchIndexProcessor - defaultdb::org.si4t.logger.LoggerIndexer::Storage(Class=com.tridion.storage.si4t.JPASearchDAOFactory, Id=defaultdb, Type=persistence, dialect=MSSQL)[Pool(CheckoutTimeout=120, IdleTimeout=120, MonitorInterval=60, Size=10, Type=jdbc), DataSource(Class=com.microsoft.sqlserver.jdbc.SQLServerDataSource)[Property(Name=serverName, Value=localhost), Property(Name=portNumber, Value=1433), Property(Name=databaseName, Value=Tridion_Broker), Property(Name=user, Value=TridionBrokerUser), Property(Name=password, Value=Tr1d10n2015)], Indexer(Class=org.si4t.logger.LoggerIndexer, DefaultCoreUrl=http://localhost, DocExtensions=pdf,docx,doc,xls,xlsx,pptx,ppt, Mode=http)]
2015-05-07 15:11:41,464 DEBUG LoggerIndexer - updateItemInIndex() called
2015-05-07 15:11:41,464 DEBUG LoggerIndexer - SearchIndexData is: [UPDATE,tcm:4-309-64,PAGE,{sgid{65,64,12,}summary{Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id,}parentsgid{65,}publicationid{4,}url{/articles/news/news1.html,}body{Sed dapibus tempus nunc, id sollicitudin ligula mattis in. Cras vel justo semper, bibendum odio in, fringilla elit. Cras at nunc fringilla, porttitor mauris eget, pharetra purus. Sed elementum consectetur massa id auctor. Mauris sed orci nec diam condimentum fermentum id eget erat. Nulla facilisi. In venenatis mauris dolor, iaculis lobortis libero porttitor sit amet. Aliquam quis egestas turpis. Morbi dolor nulla, volutpat ut nisi sed, mollis lacinia sapien.. Praesent facilisis consectetur neque. Cras vel justo semp. Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id. ,}title{Planes,}schemaid{110,}type{0,}itemtype{64,}}]
2015-05-07 15:11:41,464 DEBUG SearchIndexProcessor - Trigger indexing for item: tcm:4-309-64, action: UPDATE, storageId: defaultdb
2015-05-07 15:11:41,464 DEBUG SearchIndexProcessor - Setting Publication Id to: 4
2015-05-07 15:11:41,464 DEBUG LoggerIndexer - commit() called
2015-05-07 15:11:41,464 DEBUG LoggerIndexer - publicationId is: 4
2015-05-07 15:11:41,464 INFO JPASearchDAOFactory - End committing transaction: tcm:0-9071-66560
2015-05-07 15:11:41,464 INFO JPASearchDAOFactory - Committing Search took: 1 ms.
2015-05-07 15:11:41,464 INFO JPASearchDAOFactory - Total Commit Time was: 13 ms.
2015-05-07 15:11:41,464 DEBUG JPASearchDAOFactory - Register currently contains:
2015-05-07 15:11:41,466 DEBUG JPASearchDAOFactory - tcm:0-9071-66560
2015-05-07 15:11:41,466 DEBUG JPASearchDAOFactory - Clearing register for transaction:tcm:0-9071-66560
2015-05-07 15:14:41,694 DEBUG JPASearchPageDAO - JPASearchPageDAO init. (EM)
2015-05-07 15:14:41,735 DEBUG JPASearchPageDAO - Update. Orgpath=/articles/news/news1.html
2015-05-07 15:14:41,737 INFO TridionPublishableItemProcessor - Finding search directives.
2015-05-07 15:14:41,744 DEBUG TridionPublishableItemProcessor - Search Directive string: <indexdata><url>/articles/news/news1.html</url><title>Planes</title><publicationid>4</publicationid><schemaid>110</schemaid><itemtype>64</itemtype><parentsgid>65</parentsgid><sgid>65</sgid><sgid>64</sgid><sgid>12</sgid><type>0</type><body>Sed dapibus tempus nunc, id sollicitudin ligula mattis in. Cras vel justo semper, bibendum odio in, fringilla elit. Cras at nunc fringilla, porttitor mauris eget, pharetra purus. Sed elementum consectetur massa id auctor. Mauris sed orci nec diam condimentum fermentum id eget erat. Nulla facilisi. In venenatis mauris dolor, iaculis lobortis libero porttitor sit amet. Aliquam quis egestas turpis. Morbi dolor nulla, volutpat ut nisi sed, mollis lacinia sapien.. Praesent facilisis consectetur neque. Cras vel justo semp. Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id. </body><custom><summary>Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id</summary></custom></indexdata>
2015-05-07 15:14:41,749 INFO TridionPublishableItemProcessor - Registering tcm:4-309-64, for: UPDATE
2015-05-07 15:14:41,904 DEBUG JPASearchBinaryContentDAO - Configuration: Storage(Class=com.tridion.storage.si4t.JPASearchDAOFactory, Id=defaultdb, Type=persistence, dialect=MSSQL)[Pool(CheckoutTimeout=120, IdleTimeout=120, MonitorInterval=60, Size=10, Type=jdbc), DataSource(Class=com.microsoft.sqlserver.jdbc.SQLServerDataSource)[Property(Name=serverName, Value=localhost), Property(Name=portNumber, Value=1433), Property(Name=databaseName, Value=Tridion_Broker), Property(Name=user, Value=TridionBrokerUser), Property(Name=password, Value=Tr1d10n2015)], Indexer(Class=org.si4t.logger.LoggerIndexer, DefaultCoreUrl=http://localhost, DocExtensions=pdf,docx,doc,xls,xlsx,pptx,ppt, Mode=http)]
2015-05-07 15:14:42,042 INFO JPASearchBinaryContentDAO - Checking update for: /media/planes_tcm4-253.jpg
2015-05-07 15:14:42,283 INFO JPASearchDAOFactory - Start committing transaction: tcm:0-9072-66560
2015-05-07 15:14:42,307 DEBUG JPASearchDAOFactory - Commit Indexing Start
2015-05-07 15:14:42,308 INFO SearchIndexProcessor - Triggering Indexing for transaction: tcm:0-9072-66560
2015-05-07 15:14:42,308 DEBUG SearchIndexProcessor - Obtaining SearchIndex class for: defaultdb
2015-05-07 15:14:42,308 DEBUG SearchIndexProcessor - defaultdb::org.si4t.logger.LoggerIndexer::Storage(Class=com.tridion.storage.si4t.JPASearchDAOFactory, Id=defaultdb, Type=persistence, dialect=MSSQL)[Pool(CheckoutTimeout=120, IdleTimeout=120, MonitorInterval=60, Size=10, Type=jdbc), DataSource(Class=com.microsoft.sqlserver.jdbc.SQLServerDataSource)[Property(Name=serverName, Value=localhost), Property(Name=portNumber, Value=1433), Property(Name=databaseName, Value=Tridion_Broker), Property(Name=user, Value=TridionBrokerUser), Property(Name=password, Value=Tr1d10n2015)], Indexer(Class=org.si4t.logger.LoggerIndexer, DefaultCoreUrl=http://localhost, DocExtensions=pdf,docx,doc,xls,xlsx,pptx,ppt, Mode=http)]
2015-05-07 15:14:42,308 DEBUG LoggerIndexer - updateItemInIndex() called
2015-05-07 15:14:42,310 DEBUG LoggerIndexer - SearchIndexData is: [UPDATE,tcm:4-309-64,PAGE,{sgid{65,64,12,}summary{Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id,}parentsgid{65,}publicationid{4,}url{/articles/news/news1.html,}body{Sed dapibus tempus nunc, id sollicitudin ligula mattis in. Cras vel justo semper, bibendum odio in, fringilla elit. Cras at nunc fringilla, porttitor mauris eget, pharetra purus. Sed elementum consectetur massa id auctor. Mauris sed orci nec diam condimentum fermentum id eget erat. Nulla facilisi. In venenatis mauris dolor, iaculis lobortis libero porttitor sit amet. Aliquam quis egestas turpis. Morbi dolor nulla, volutpat ut nisi sed, mollis lacinia sapien.. Praesent facilisis consectetur neque. Cras vel justo semp. Praesent facilisis consectetur neque, quis varius justo dapibus at. Fusce ullamcorper tellus in neque dictum commodo. Duis pretium rhoncus est non scelerisque. Nam placerat lectus augue, a lacinia lectus aliquam id. ,}title{Planes,}schemaid{110,}type{0,}itemtype{64,}}]
2015-05-07 15:14:42,310 DEBUG SearchIndexProcessor - Trigger indexing for item: tcm:4-309-64, action: UPDATE, storageId: defaultdb
2015-05-07 15:14:42,310 DEBUG SearchIndexProcessor - Setting Publication Id to: 4
2015-05-07 15:14:42,310 DEBUG LoggerIndexer - commit() called
2015-05-07 15:14:42,310 DEBUG LoggerIndexer - publicationId is: 4
2015-05-07 15:14:42,310 INFO JPASearchDAOFactory - End committing transaction: tcm:0-9072-66560
2015-05-07 15:14:42,310 INFO JPASearchDAOFactory - Committing Search took: 3 ms.
2015-05-07 15:14:42,310 INFO JPASearchDAOFactory - Total Commit Time was: 25 ms.
2015-05-07 15:14:42,310 DEBUG JPASearchDAOFactory - Register currently contains:
2015-05-07 15:14:42,311 DEBUG JPASearchDAOFactory - tcm:0-9072-66560
2015-05-07 15:14:42,311 DEBUG JPASearchDAOFactory - Clearing register for transaction:tcm:0-9072-66560