You are viewing a plain text version of this content. The canonical link for it is here.
Posted to notifications@ofbiz.apache.org by "Jacques Le Roux (Jira)" <ji...@apache.org> on 2020/09/26 11:08:00 UTC

[jira] [Commented] (OFBIZ-10426) When creating blog or forums, it failed to save

    [ https://issues.apache.org/jira/browse/OFBIZ-10426?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17202582#comment-17202582 ] 

Jacques Le Roux commented on OFBIZ-10426:
-----------------------------------------

Hi Aman,

I saw that you put 2 images with succesful creations for blog and articles. So I tried locally with R17 HEAD too, after doing a "{{g cleanAll eclipse loadAll ofbiz}}" to be sure there was no interactions with a previous existing trunk Derby DB.

I was able to create a new "test" blog, but not to create a "test" article inside it. The problem is with the createContentPurpose service. It works in trunk, did not try with R18. Here is the whole (sorry long but complete) trace:

{noformat}
   ____  __________  _
  / __ \/ ____/ __ )(_)___
 / / / / /_  / __  / /_  /
/ /_/ / __/ / /_/ / / / /_
\____/_/   /_____/_/ /___/  is started and ready.

2020-09-26 12:52:16,162 |main                 |BirtContainer                 |I| BIRT supported formats: xlsx, postscript, docx, pptx, pdf, ppt, xls_spudsoft, doc, html, odp, xls, odt, ods
2020-09-26 12:52:16,162 |main                 |ContainerLoader               |I| Started container birt-container
2020-09-26 12:52:16,922 |OFBiz-JobPoller      |JobManager                    |I| No crashed jobs to re-schedule
2020-09-26 12:52:17,045 |OFBiz-JobQueue-1     |TransactionUtil               |W| No transaction in place, so not suspending.
2020-09-26 12:52:17,052 |OFBiz-JobQueue-1     |SequenceUtil                  |W| Lock failed; no sequence row was found, will try to add a new one for sequence: JobSandbox
2020-09-26 12:52:17,066 |OFBiz-JobQueue-1     |SequenceUtil                  |I| Got bank of sequenced IDs for [JobSandbox]; curSeqId=10000, maxSeqId=10100, bankSize=100
2020-09-26 12:52:17,072 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Delete auto-save shopping list for anonymous users] Id [8009] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:17,072 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [Create Also Bought Product Associations] Id [8008] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:17,089 |OFBiz-JobQueue-0     |AbstractEngine                |I| Loaded Service Locations: {eedcc-test=https://localhost:8443/webtools/control/httpService, entity-sync-http=https://localhost:8443/webtools/control/httpServ
ice, rita-rmi=rmi://localhost:1099/RMIDispatcher, main-rmi=rmi://localhost:1099/RMIDispatcher, main-soap=http://localhost:8080/webtools/control/SOAPService, entity-sync-rmi=rmi://localhost:1099/RMIDispatcher, main-http=http://localhost:8
080/webtools/control/httpService}
2020-09-26 12:52:17,160 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/autoDeleteAutoSaveShoppingList] finished in [77] milliseconds
2020-09-26 12:52:17,168 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Replacement Held Order Auto-Cancel] Id [8007] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:17,222 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/autoCancelReplacementOrders] finished in [53] milliseconds
2020-09-26 12:52:17,244 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [BackOrder Notification] Id [8000] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:17,282 |OFBiz-JobQueue-0     |InventoryServices             |I| OOS Inventory Items: 0
2020-09-26 12:52:17,282 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/checkInventoryAvailability] finished in [38] milliseconds
2020-09-26 12:52:17,291 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Auto-create Fixed Asset Maintenances] Id [FAM_AUTO_CREATE] -- Next runtime: Sat Sep 26 13:52:17 CEST 2020
2020-09-26 12:52:17,358 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/createAlsoBoughtProductAssocsForOrder] finished in [161] milliseconds
2020-09-26 12:52:17,361 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/createAlsoBoughtProductAssocsForOrder] finished in [3] milliseconds
2020-09-26 12:52:17,361 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/createAlsoBoughtProductAssocs] finished in [278] milliseconds
2020-09-26 12:52:17,391 |OFBiz-JobQueue-1     |PersistedServiceJob           |W| Persisted Job [9000] references a RecurrenceInfo, recommend using TemporalExpression instead
2020-09-26 12:52:17,406 |OFBiz-JobQueue-0     |ScriptUtil                    |I| The following 2 scripting engines were found:
2020-09-26 12:52:17,406 |OFBiz-JobQueue-0     |ScriptUtil                    |I| Engine name: Oracle Nashorn
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Version: 1.8.0_202
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Language: ECMAScript
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Engine supports the following extensions:
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     js
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Engine has the following short names:
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     nashorn
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     Nashorn
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     js
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     JS
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     JavaScript
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     javascript
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     ECMAScript
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     ecmascript
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I| Engine name: Groovy Scripting Engine
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Version: 2.0
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Language: Groovy
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Engine supports the following extensions:
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     groovy
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|   Engine has the following short names:
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     groovy
2020-09-26 12:52:17,407 |OFBiz-JobQueue-0     |ScriptUtil                    |I|     Groovy
2020-09-26 12:52:17,461 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [Auto Reconcile Financial Account] Id [9000] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:17,498 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]
2020-09-26 12:52:17,498 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/fixedAssetPermissionCheck] finished in [206] milliseconds
2020-09-26 12:52:17,573 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/createMaintsFromTimeInterval] finished in [282] milliseconds
2020-09-26 12:52:17,584 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Purge Old Store Auto-Entered Promos] Id [8100] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:17,605 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/purgeOldStoreAutoPromos] finished in [20] milliseconds
2020-09-26 12:52:17,612 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Send Email] Id [SENDEMAIL] -- Next runtime: Sat Sep 26 13:07:17 CEST 2020
2020-09-26 12:52:17,702 |OFBiz-JobQueue-0     |CommunicationEventServices    |I| Sending communicationEvent: DEMO-COM-PRODUCT-1
2020-09-26 12:52:17,795 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [sendMail] on [in-validate] got false for condition: [communicationEventId][is-empty][true][String]
2020-09-26 12:52:17,855 |OFBiz-JobQueue-0     |EmailServices                 |I| SendMail Running, for communicationEventId : DEMO-COM-PRODUCT-1
2020-09-26 12:52:17,952 |OFBiz-JobQueue-0     |EmailServices                 |I| Mail notifications disabled in general.properties; mail with subject [PD#DEMO-PRODUCT-1 - Demo Product 1] not sent to addressee [ofbizScrumProductOwner@exam
ple.com]
2020-09-26 12:52:17,956 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: updateCommEventAfterEmail, triggered by rule on Service: sendMail
2020-09-26 12:52:18,004 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [43] milliseconds
2020-09-26 12:52:18,045 |OFBiz-JobQueue-0     |ModelService                  |I| Set default value [N] for parameter [setRoleStatusToComplete]
2020-09-26 12:52:18,047 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [1] milliseconds
2020-09-26 12:52:18,072 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/setCommunicationEventStatus] finished in [27] milliseconds
2020-09-26 12:52:18,139 |OFBiz-JobQueue-0     |UtilProperties                |I| ResourceBundle DefaultMessagesUiLabels (en) created in 0.065s with 11 properties
2020-09-26 12:52:18,140 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,140 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,140 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,140 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| To Field (oldStatusId) is not found in context for updateCommunicationEvent, defaulting to null.
2020-09-26 12:52:18,140 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: updateCommStatusFromCommEvent, triggered by rule on Service: updateCommunicationEvent
2020-09-26 12:52:18,218 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommStatusFromCommEvent] finished in [78] milliseconds
2020-09-26 12:52:18,218 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommunicationEvent] finished in [259] milliseconds
2020-09-26 12:52:18,256 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommEventAfterEmail] finished in [299] milliseconds
2020-09-26 12:52:18,257 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/sendMail] finished in [463] milliseconds
2020-09-26 12:52:18,262 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [2] milliseconds
2020-09-26 12:52:18,265 |OFBiz-JobQueue-0     |ModelService                  |I| Set default value [N] for parameter [setRoleStatusToComplete]
2020-09-26 12:52:18,268 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [2] milliseconds
2020-09-26 12:52:18,273 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/setCommunicationEventStatus] finished in [8] milliseconds
2020-09-26 12:52:18,273 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,273 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,273 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,273 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| To Field (oldStatusId) is not found in context for updateCommunicationEvent, defaulting to null.
2020-09-26 12:52:18,273 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: updateCommStatusFromCommEvent, triggered by rule on Service: updateCommunicationEvent
2020-09-26 12:52:18,276 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommStatusFromCommEvent] finished in [3] milliseconds
2020-09-26 12:52:18,277 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommunicationEvent] finished in [16] milliseconds
2020-09-26 12:52:18,277 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/setCommEventComplete] finished in [18] milliseconds
2020-09-26 12:52:18,278 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/sendCommEventAsEmail] finished in [606] milliseconds
2020-09-26 12:52:18,281 |OFBiz-JobQueue-0     |CommunicationEventServices    |I| Sending communicationEvent: DEMO-COM-PRODUCT-2
2020-09-26 12:52:18,282 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [sendMail] on [in-validate] got false for condition: [communicationEventId][is-empty][true][String]
2020-09-26 12:52:18,283 |OFBiz-JobQueue-0     |EmailServices                 |I| SendMail Running, for communicationEventId : DEMO-COM-PRODUCT-2
2020-09-26 12:52:18,300 |OFBiz-JobQueue-0     |EmailServices                 |I| Mail notifications disabled in general.properties; mail with subject [PD#DEMO-PRODUCT-2 - Demo Product 2] not sent to addressee [ofbizScrumProductOwner@exam
ple.com]
2020-09-26 12:52:18,300 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: updateCommEventAfterEmail, triggered by rule on Service: sendMail
2020-09-26 12:52:18,303 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [2] milliseconds
2020-09-26 12:52:18,307 |OFBiz-JobQueue-0     |ModelService                  |I| Set default value [N] for parameter [setRoleStatusToComplete]
2020-09-26 12:52:18,309 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [2] milliseconds
2020-09-26 12:52:18,313 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/setCommunicationEventStatus] finished in [6] milliseconds
2020-09-26 12:52:18,313 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,313 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,313 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,314 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| To Field (oldStatusId) is not found in context for updateCommunicationEvent, defaulting to null.
2020-09-26 12:52:18,314 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: updateCommStatusFromCommEvent, triggered by rule on Service: updateCommunicationEvent
2020-09-26 12:52:18,315 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommStatusFromCommEvent] finished in [1] milliseconds
2020-09-26 12:52:18,316 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommunicationEvent] finished in [14] milliseconds
2020-09-26 12:52:18,317 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommEventAfterEmail] finished in [17] milliseconds
2020-09-26 12:52:18,317 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/sendMail] finished in [35] milliseconds
2020-09-26 12:52:18,323 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [3] milliseconds
2020-09-26 12:52:18,325 |OFBiz-JobQueue-0     |ModelService                  |I| Set default value [N] for parameter [setRoleStatusToComplete]
2020-09-26 12:52:18,327 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/partyCommunicationEventPermissionCheck] finished in [2] milliseconds
2020-09-26 12:52:18,330 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/setCommunicationEventStatus] finished in [5] milliseconds
2020-09-26 12:52:18,330 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,330 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,330 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [updateCommunicationEvent] on [commit] got false for condition: [statusId][equals][COM_ENTERED][true][String]
2020-09-26 12:52:18,330 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| To Field (oldStatusId) is not found in context for updateCommunicationEvent, defaulting to null.
2020-09-26 12:52:18,330 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: updateCommStatusFromCommEvent, triggered by rule on Service: updateCommunicationEvent
2020-09-26 12:52:18,332 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommStatusFromCommEvent] finished in [1] milliseconds
2020-09-26 12:52:18,332 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/updateCommunicationEvent] finished in [12] milliseconds
2020-09-26 12:52:18,332 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/setCommEventComplete] finished in [13] milliseconds
2020-09-26 12:52:18,333 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/sendCommEventAsEmail] finished in [53] milliseconds
2020-09-26 12:52:18,352 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/sendEmailDated] finished in [739] milliseconds
2020-09-26 12:52:18,401 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/autoFinAccountReconciliation] finished in [939] milliseconds
2020-09-26 12:52:18,429 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [Clear EntitySyncRemove Info] Id [8200] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:18,430 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Re-Try Failed Auths NSF] Id [8004] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:18,433 |OFBiz-JobQueue-1     |EntitySyncServices            |I| Running cleanSyncRemoveInfo
2020-09-26 12:52:18,455 |OFBiz-JobQueue-0     |PaymentGatewayServices        |I| Processing failed order re-auth(s)
2020-09-26 12:52:18,455 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/retryFailedAuthNsfs] finished in [25] milliseconds
2020-09-26 12:52:18,461 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Re-Try Failed Auths] Id [8001] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:18,469 |OFBiz-JobQueue-0     |PaymentGatewayServices        |I| Processing failed order re-auth(s)
2020-09-26 12:52:18,469 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/retryFailedAuths] finished in [8] milliseconds
2020-09-26 12:52:18,476 |OFBiz-JobQueue-1     |EntitySyncServices            |I| In cleanSyncRemoveInfo removed [0] values with TX timestamp before [2020-09-25 12:52:18.462]
2020-09-26 12:52:18,476 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/cleanSyncRemoveInfo] finished in [47] milliseconds
2020-09-26 12:52:18,478 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [Extend expired Subscriptions] Id [8005] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:18,482 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [Run Auto-Reorders] Id [8003] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:18,499 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/runShoppingListAutoReorder] finished in [16] milliseconds
2020-09-26 12:52:18,507 |OFBiz-JobQueue-1     |PersistedServiceJob           |W| Persisted Job [8500] references a RecurrenceInfo, recommend using TemporalExpression instead
2020-09-26 12:52:18,521 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [Generate Invoice template] Id [8500] -- Next runtime: Wed Oct 14 22:00:00 CEST 2020
2020-09-26 12:52:18,623 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/autoGenerateInvoiceFromExistingInvoice] finished in [55] milliseconds
2020-09-26 12:52:18,629 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [Cancels all orders after date] Id [8006] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:18,707 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/cancelAllBackOrders] finished in [78] milliseconds
2020-09-26 12:52:18,713 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [Run Nominated Service on Subscription Expiry] Id [8010] -- Next runtime: Sun Sep 27 00:00:00 CEST 2020
2020-09-26 12:52:18,720 |OFBiz-JobQueue-0     |UtilProperties                |I| ResourceBundle OrderUiLabels (en) created in 0.186s with 983 properties
2020-09-26 12:52:18,722 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/runSubscriptionAutoReorders] finished in [243] milliseconds
2020-09-26 12:52:18,725 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/runServiceOnSubscriptionExpiry] finished in [11] milliseconds
2020-09-26 12:56:42,649 |jsse-nio-8443-exec-4 |ControlEventListener          |I| Creating session:  hidden sessionId by default.
2020-09-26 12:56:42,655 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[blogMain(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:56:42,661 |jsse-nio-8443-exec-4 |VisitHandler                  |I| Found visitorId [10000] in cookie
2020-09-26 12:56:42,692 |jsse-nio-8443-exec-4 |TransactionUtil               |W| No transaction in place, so not suspending.
2020-09-26 12:56:42,714 |jsse-nio-8443-exec-4 |SequenceUtil                  |W| Lock failed; no sequence row was found, will try to add a new one for sequence: Visitor
2020-09-26 12:56:42,720 |jsse-nio-8443-exec-4 |SequenceUtil                  |I| Got bank of sequenced IDs for [Visitor]; curSeqId=10000, maxSeqId=10100, bankSize=100
2020-09-26 12:56:42,723 |jsse-nio-8443-exec-4 |VisitHandler                  |I| The visitorId [10000] found in cookie was invalid, creating new Visitor with ID [10000]
2020-09-26 12:56:42,725 |jsse-nio-8443-exec-4 |TransactionUtil               |W| No transaction in place, so not suspending.
2020-09-26 12:56:42,728 |jsse-nio-8443-exec-4 |SequenceUtil                  |W| Lock failed; no sequence row was found, will try to add a new one for sequence: Visit
2020-09-26 12:56:42,737 |jsse-nio-8443-exec-4 |SequenceUtil                  |I| Got bank of sequenced IDs for [Visit]; curSeqId=10000, maxSeqId=10100, bankSize=100
2020-09-26 12:56:42,789 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.001s, 5 requests, 3 views in file:/C:/projectsASF/Git/ofbiz-framework/plugins/lucene/webapp/content/WEB-INF/controller.xml
2020-09-26 12:56:42,810 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.004s, 379 requests, 154 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/content/webapp/content/WEB-INF/controller.xml
2020-09-26 12:56:42,835 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 48 requests, 22 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/common-controller.xml
2020-09-26 12:56:42,860 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.001s, 0 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/handlers-controller.xml
2020-09-26 12:56:42,880 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/webapp/WEB-INF/controller.xml
2020-09-26 12:56:42,881 |jsse-nio-8443-exec-4 |RequestHandler                |I| This is the first request in this visit. Hidden sessionId by default.
2020-09-26 12:56:43,661 |jsse-nio-8443-exec-4 |RequestHandler                |I| Rendering View [login].  Hidden sessionId by default.
2020-09-26 12:56:43,706 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [39] milliseconds
2020-09-26 12:56:44,672 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 27 screens in 0.671s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
2020-09-26 12:56:44,869 |jsse-nio-8443-exec-4 |FreeMarkerWorker              |I| loading properties: file:/C:/projectsASF/Git/ofbiz-framework/framework/webapp/config/freemarkerTransforms.properties
2020-09-26 12:56:44,870 |jsse-nio-8443-exec-4 |FreeMarkerWorker              |I| loading properties: file:/C:/projectsASF/Git/ofbiz-framework/framework/widget/config/freemarkerTransforms.properties
2020-09-26 12:56:44,871 |jsse-nio-8443-exec-4 |FreeMarkerWorker              |I| loading properties: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/config/freemarkerTransforms.properties
2020-09-26 12:56:44,872 |jsse-nio-8443-exec-4 |FreeMarkerWorker              |I| loading properties: file:/C:/projectsASF/Git/ofbiz-framework/applications/product/config/freemarkerTransforms.properties
2020-09-26 12:56:45,055 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 26 screens in 0.201s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common/widget/CommonScreens.xml
2020-09-26 12:56:45,076 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 15 screens in 0.02s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/CommonScreens.xml
2020-09-26 12:56:45,182 |jsse-nio-8443-exec-4 |UtilProperties                |I| ResourceBundle ContentUiLabels (fr) created in 0.105s with 540 properties
2020-09-26 12:56:45,346 |jsse-nio-8443-exec-4 |UtilProperties                |I| ResourceBundle CommonUiLabels (fr) created in 0.163s with 844 properties
2020-09-26 12:56:45,431 |jsse-nio-8443-exec-4 |UtilProperties                |I| ResourceBundle WorkEffortUiLabels (fr) created in 0.084s with 382 properties
2020-09-26 12:56:45,556 |jsse-nio-8443-exec-4 |UtilProperties                |I| ResourceBundle PartyUiLabels (fr) created in 0.125s with 749 properties
2020-09-26 12:56:45,784 |jsse-nio-8443-exec-4 |UtilProperties                |I| ResourceBundle ProductUiLabels (fr) created in 0.228s with 1999 properties
2020-09-26 12:56:45,882 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 1 screens in 0.097s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
2020-09-26 12:56:45,935 |jsse-nio-8443-exec-4 |UtilProperties                |I| ResourceBundle CommonExtUiLabels (fr) created in 0.053s with 7 properties
2020-09-26 12:56:45,936 |jsse-nio-8443-exec-4 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]
2020-09-26 12:56:46,102 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [48] milliseconds
2020-09-26 12:56:46,672 |jsse-nio-8443-exec-4 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:56:46,686 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[blogMain(Domain:https://localhost)] Request Done- total:4.031,since last([blogMain(Domain:...):4.031]]
2020-09-26 12:56:51,263 |jsse-nio-8443-exec-1 |ControlServlet                |T| [[[login(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:56:51,267 |jsse-nio-8443-exec-1 |LoginWorker                   |I| Setting default delegator
2020-09-26 12:56:51,331 |jsse-nio-8443-exec-1 |ServiceDispatcher             |T| Sync service [lucene/userLogin] finished in [64] milliseconds
2020-09-26 12:56:51,332 |jsse-nio-8443-exec-1 |VisitHandler                  |I| Found visitorId [10000] in cookie
2020-09-26 12:56:51,338 |jsse-nio-8443-exec-1 |ServiceDispatcher             |T| Sync service [lucene/preferenceGetSetPermission] finished in [3] milliseconds
2020-09-26 12:56:51,351 |jsse-nio-8443-exec-1 |ServiceDispatcher             |T| Sync service [lucene/setUserPreference] finished in [17] milliseconds
2020-09-26 12:56:51,414 |jsse-nio-8443-exec-1 |UtilProperties                |I| ResourceBundle SecurityextUiLabels (fr) created in 0.059s with 62 properties
2020-09-26 12:56:51,414 |jsse-nio-8443-exec-1 |RequestHandler                |I| Ran Event [java:org.apache.ofbiz.webapp.control.LoginWorker#login] from [request], result is [error]
2020-09-26 12:56:51,415 |jsse-nio-8443-exec-1 |RequestHandler                |E| Request login caused an error with the following message: Impossible de se connecter � cette application.
2020-09-26 12:56:51,416 |jsse-nio-8443-exec-1 |RequestHandler                |I| Rendering View [login].  Hidden sessionId by default.
2020-09-26 12:56:51,418 |jsse-nio-8443-exec-1 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [2] milliseconds
2020-09-26 12:56:51,425 |jsse-nio-8443-exec-1 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]
2020-09-26 12:56:51,429 |jsse-nio-8443-exec-1 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [2] milliseconds
2020-09-26 12:56:51,459 |jsse-nio-8443-exec-1 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:56:51,460 |jsse-nio-8443-exec-1 |ControlServlet                |T| [[[login(Domain:https://localhost)] Request Done- total:0.197,since last([login(Domain:htt...):0.197]]
2020-09-26 12:56:57,923 |jsse-nio-8443-exec-6 |ControlServlet                |T| [[[login(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:56:57,938 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.0s, 5 requests, 3 views in file:/C:/projectsASF/Git/ofbiz-framework/plugins/lucene/webapp/content/WEB-INF/controller.xml
2020-09-26 12:56:57,960 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.003s, 379 requests, 154 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/content/webapp/content/WEB-INF/controller.xml
2020-09-26 12:56:57,978 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/common-controller.xml
2020-09-26 12:56:57,994 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/handlers-controller.xml
2020-09-26 12:56:58,008 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/webapp/WEB-INF/controller.xml
2020-09-26 12:56:58,011 |jsse-nio-8443-exec-6 |LoginWorker                   |I| Setting default delegator
2020-09-26 12:56:58,013 |jsse-nio-8443-exec-6 |ServiceDispatcher             |T| Sync service [lucene/userLogin] finished in [2] milliseconds
2020-09-26 12:56:58,013 |jsse-nio-8443-exec-6 |VisitHandler                  |I| Found visitorId [10000] in cookie
2020-09-26 12:56:58,017 |jsse-nio-8443-exec-6 |ServiceDispatcher             |T| Sync service [lucene/preferenceGetSetPermission] finished in [2] milliseconds
2020-09-26 12:56:58,022 |jsse-nio-8443-exec-6 |ServiceDispatcher             |T| Sync service [lucene/setUserPreference] finished in [7] milliseconds
2020-09-26 12:56:58,022 |jsse-nio-8443-exec-6 |RequestHandler                |I| Ran Event [java:org.apache.ofbiz.webapp.control.LoginWorker#login] from [request], result is [error]
2020-09-26 12:56:58,023 |jsse-nio-8443-exec-6 |RequestHandler                |E| Request login caused an error with the following message: Impossible de se connecter � cette application.
2020-09-26 12:56:58,023 |jsse-nio-8443-exec-6 |RequestHandler                |I| Rendering View [login].  Hidden sessionId by default.
2020-09-26 12:56:58,025 |jsse-nio-8443-exec-6 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [2] milliseconds
2020-09-26 12:56:58,034 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 27 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
2020-09-26 12:56:58,088 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 26 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common/widget/CommonScreens.xml
2020-09-26 12:56:58,099 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 15 screens in 0.011s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/CommonScreens.xml
2020-09-26 12:56:58,105 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 1 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
2020-09-26 12:56:58,105 |jsse-nio-8443-exec-6 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]
2020-09-26 12:56:58,147 |jsse-nio-8443-exec-6 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [10] milliseconds
2020-09-26 12:56:58,172 |jsse-nio-8443-exec-6 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:56:58,174 |jsse-nio-8443-exec-6 |ControlServlet                |T| [[[login(Domain:https://localhost)] Request Done- total:0.251,since last([login(Domain:htt...):0.251]]
2020-09-26 12:57:11,290 |jsse-nio-8443-exec-9 |ControlServlet                |T| [[[login(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:57:11,306 |jsse-nio-8443-exec-9 |ConfigXMLReader               |I| controller loaded: 0.0s, 5 requests, 3 views in file:/C:/projectsASF/Git/ofbiz-framework/plugins/lucene/webapp/content/WEB-INF/controller.xml
2020-09-26 12:57:11,327 |jsse-nio-8443-exec-9 |ConfigXMLReader               |I| controller loaded: 0.003s, 379 requests, 154 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/content/webapp/content/WEB-INF/controller.xml
2020-09-26 12:57:11,342 |jsse-nio-8443-exec-9 |ConfigXMLReader               |I| controller loaded: 0.0s, 48 requests, 22 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/common-controller.xml
2020-09-26 12:57:11,377 |jsse-nio-8443-exec-9 |ConfigXMLReader               |I| controller loaded: 0.001s, 0 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/handlers-controller.xml
2020-09-26 12:57:11,389 |jsse-nio-8443-exec-9 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/webapp/WEB-INF/controller.xml
2020-09-26 12:57:11,394 |jsse-nio-8443-exec-9 |LoginWorker                   |I| Setting default delegator
2020-09-26 12:57:11,399 |jsse-nio-8443-exec-9 |ServiceDispatcher             |T| Sync service [lucene/userLogin] finished in [5] milliseconds
2020-09-26 12:57:11,399 |jsse-nio-8443-exec-9 |VisitHandler                  |I| Found visitorId [10000] in cookie
2020-09-26 12:57:11,403 |jsse-nio-8443-exec-9 |ServiceDispatcher             |T| Sync service [lucene/setUserPreference] finished in [3] milliseconds
2020-09-26 12:57:11,408 |jsse-nio-8443-exec-9 |ServiceDispatcher             |T| Sync service [lucene/getUserPreference] finished in [2] milliseconds
2020-09-26 12:57:11,410 |jsse-nio-8443-exec-9 |ServiceDispatcher             |T| Sync service [lucene/getUserPreference] finished in [2] milliseconds
2020-09-26 12:57:11,442 |jsse-nio-8443-exec-9 |RequestHandler                |I| Ran Event [java:org.apache.ofbiz.webapp.control.LoginWorker#login] from [request], result is [success]
2020-09-26 12:57:11,442 |jsse-nio-8443-exec-9 |RequestHandler                |I| [Doing Previous Request]: /blogMain Hidden sessionId by default.
2020-09-26 12:57:11,443 |jsse-nio-8443-exec-9 |RequestHandler                |I| Sending redirect to: [https://localhost:8443/content/control/blogMain].  Hidden sessionId by default.
2020-09-26 12:57:11,445 |jsse-nio-8443-exec-9 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:57:11,446 |jsse-nio-8443-exec-9 |ControlServlet                |T| [[[login(Domain:https://localhost)] Request Done- total:0.156,since last([login(Domain:htt...):0.156]]
2020-09-26 12:57:11,559 |jsse-nio-8443-exec-2 |ControlServlet                |T| [[[blogMain(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:57:11,595 |jsse-nio-8443-exec-2 |RequestHandler                |I| Rendering View [blogMain].  Hidden sessionId by default.
2020-09-26 12:57:11,598 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [1] milliseconds
2020-09-26 12:57:11,612 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 8 screens in 0.011s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/forum/BlogScreens.xml
2020-09-26 12:57:11,661 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 15 screens in 0.01s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/CommonScreens.xml
2020-09-26 12:57:11,670 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 1 screens in 0.008s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
2020-09-26 12:57:11,740 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [9] milliseconds
2020-09-26 12:57:11,766 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 27 screens in 0.01s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
2020-09-26 12:57:11,839 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 26 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common/widget/CommonScreens.xml
2020-09-26 12:57:12,198 |jsse-nio-8443-exec-2 |UtilProperties                |I| ResourceBundle ContentEntityLabels (fr) created in 0.083s with 210 properties
2020-09-26 12:57:12,290 |jsse-nio-8443-exec-2 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:57:12,310 |jsse-nio-8443-exec-2 |ControlServlet                |T| [[[blogMain(Domain:https://localhost)] Request Done- total:0.751,since last([blogMain(Domain:...):0.751]]
2020-09-26 12:57:23,308 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[editBlog(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:57:23,322 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 5 requests, 3 views in file:/C:/projectsASF/Git/ofbiz-framework/plugins/lucene/webapp/content/WEB-INF/controller.xml
2020-09-26 12:57:23,345 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.004s, 379 requests, 154 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/content/webapp/content/WEB-INF/controller.xml
2020-09-26 12:57:23,363 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/common-controller.xml
2020-09-26 12:57:23,379 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.001s, 0 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/handlers-controller.xml
2020-09-26 12:57:23,394 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/webapp/WEB-INF/controller.xml
2020-09-26 12:57:23,400 |jsse-nio-8443-exec-4 |RequestHandler                |I| Rendering View [EditBlog].  Hidden sessionId by default.
2020-09-26 12:57:23,401 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [1] milliseconds
2020-09-26 12:57:23,409 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 8 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/forum/BlogScreens.xml
2020-09-26 12:57:23,410 |jsse-nio-8443-exec-4 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:Content][contentId,null()]
2020-09-26 12:57:23,416 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 15 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/CommonScreens.xml
2020-09-26 12:57:23,423 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 1 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
2020-09-26 12:57:23,472 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [14] milliseconds
2020-09-26 12:57:23,491 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 27 screens in 0.01s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
2020-09-26 12:57:23,586 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 26 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common/widget/CommonScreens.xml
2020-09-26 12:57:23,737 |jsse-nio-8443-exec-4 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:57:23,738 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[editBlog(Domain:https://localhost)] Request Done- total:0.43,since last([editBlog(Domain:...):0.43]]
2020-09-26 12:57:33,395 |jsse-nio-8443-exec-3 |ControlServlet                |T| [[[newBlog(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:57:33,413 |jsse-nio-8443-exec-3 |ConfigXMLReader               |I| controller loaded: 0.0s, 5 requests, 3 views in file:/C:/projectsASF/Git/ofbiz-framework/plugins/lucene/webapp/content/WEB-INF/controller.xml
2020-09-26 12:57:33,436 |jsse-nio-8443-exec-3 |ConfigXMLReader               |I| controller loaded: 0.003s, 379 requests, 154 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/content/webapp/content/WEB-INF/controller.xml
2020-09-26 12:57:33,452 |jsse-nio-8443-exec-3 |ConfigXMLReader               |I| controller loaded: 0.0s, 48 requests, 22 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/common-controller.xml
2020-09-26 12:57:33,466 |jsse-nio-8443-exec-3 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/handlers-controller.xml
2020-09-26 12:57:33,481 |jsse-nio-8443-exec-3 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/webapp/WEB-INF/controller.xml
2020-09-26 12:57:33,512 |jsse-nio-8443-exec-3 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:57:33,512 |jsse-nio-8443-exec-3 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:57:33,513 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [26] milliseconds
2020-09-26 12:57:33,531 |jsse-nio-8443-exec-3 |SequenceUtil                  |W| Lock failed; no sequence row was found, will try to add a new one for sequence: Content
2020-09-26 12:57:33,537 |jsse-nio-8443-exec-3 |SequenceUtil                  |I| Got bank of sequenced IDs for [Content]; curSeqId=10000, maxSeqId=10010, bankSize=10
2020-09-26 12:57:33,697 |jsse-nio-8443-exec-3 |UtilProperties                |I| ResourceBundle CommonEntityLabels (fr) created in 0.157s with 1395 properties
2020-09-26 12:57:33,718 |jsse-nio-8443-exec-3 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: Content
2020-09-26 12:57:33,831 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [113] milliseconds
2020-09-26 12:57:33,832 |jsse-nio-8443-exec-3 |ServiceEcaCondition           |I| From Field (partyId) is not found in context for createContent, defaulting to null.
2020-09-26 12:57:33,832 |jsse-nio-8443-exec-3 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [partyId][is-not-empty][true][String]
2020-09-26 12:57:33,832 |jsse-nio-8443-exec-3 |ServiceEcaCondition           |I| From Field (partyId) is not found in context for createContent, defaulting to null.
2020-09-26 12:57:33,832 |jsse-nio-8443-exec-3 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [partyId][is-not-empty][true][String]
2020-09-26 12:57:33,832 |jsse-nio-8443-exec-3 |ServiceEcaCondition           |I| From Field (partyId) is not found in context for createContent, defaulting to null.
2020-09-26 12:57:33,832 |jsse-nio-8443-exec-3 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:57:33,833 |jsse-nio-8443-exec-3 |ServiceEcaSetField            |I| Expanded String: admin
2020-09-26 12:57:33,833 |jsse-nio-8443-exec-3 |ServiceEcaRule                |I| Running Service ECA Service: createContentRole, triggered by rule on Service: createContent
2020-09-26 12:57:33,845 |jsse-nio-8443-exec-3 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:57:33,845 |jsse-nio-8443-exec-3 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / 10000] completed; returning hasPermission = true
2020-09-26 12:57:33,845 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [4] milliseconds
2020-09-26 12:57:33,846 |jsse-nio-8443-exec-3 |ServiceEcaRule                |I| Running Service ECA Service: ensurePartyRole, triggered by rule on Service: createContentRole
2020-09-26 12:57:33,877 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/ensurePartyRole] finished in [31] milliseconds
2020-09-26 12:57:33,878 |jsse-nio-8443-exec-3 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:ContentRole][contentId,10000(java.lang.String)][fromDate,null()][partyId,admin(j
ava.lang.String)][roleTypeId,OWNER(java.lang.String)]
2020-09-26 12:57:33,884 |jsse-nio-8443-exec-3 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: ContentRole
2020-09-26 12:57:33,913 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [27] milliseconds
2020-09-26 12:57:33,969 |jsse-nio-8443-exec-3 |UtilProperties                |I| ResourceBundle ServiceUiLabels (fr) created in 0.056s with 4 properties
2020-09-26 12:57:33,970 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/createContentRole] finished in [130] milliseconds
2020-09-26 12:57:33,970 |jsse-nio-8443-exec-3 |ServiceEcaCondition           |I| From Field (contentIdTo) is not found in context for createContent, defaulting to null.
2020-09-26 12:57:33,970 |jsse-nio-8443-exec-3 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [contentIdTo][is-not-empty][true][String]
2020-09-26 12:57:33,970 |jsse-nio-8443-exec-3 |ServiceEcaRule                |I| Running Service ECA Service: createContentAssoc, triggered by rule on Service: createContent
2020-09-26 12:57:33,972 |jsse-nio-8443-exec-3 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_UPDATE
2020-09-26 12:57:33,972 |jsse-nio-8443-exec-3 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [UPDATE / BLOGROOT] completed; returning hasPermission = true
2020-09-26 12:57:33,972 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [2] milliseconds
2020-09-26 12:57:33,986 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/createContentAssoc] finished in [15] milliseconds
2020-09-26 12:57:33,986 |jsse-nio-8443-exec-3 |ServiceEcaCondition           |I| From Field (contentPurposeTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:57:33,986 |jsse-nio-8443-exec-3 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [contentPurposeTypeId][is-not-empty][true][String]
2020-09-26 12:57:33,986 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/createContent] finished in [499] milliseconds
2020-09-26 12:57:33,986 |jsse-nio-8443-exec-3 |RequestHandler                |I| Ran Event [service:#createContent] from [request], result is [success]
2020-09-26 12:57:33,987 |jsse-nio-8443-exec-3 |RequestHandler                |I| Rendering View [blogMain].  Hidden sessionId by default.
2020-09-26 12:57:33,988 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [1] milliseconds
2020-09-26 12:57:33,996 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 8 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/forum/BlogScreens.xml
2020-09-26 12:57:34,005 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 15 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/CommonScreens.xml
2020-09-26 12:57:34,011 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 1 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
2020-09-26 12:57:34,057 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [10] milliseconds
2020-09-26 12:57:34,069 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 27 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
2020-09-26 12:57:34,128 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 26 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common/widget/CommonScreens.xml
2020-09-26 12:57:34,217 |jsse-nio-8443-exec-3 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:57:34,242 |jsse-nio-8443-exec-3 |ControlServlet                |T| [[[newBlog(Domain:https://localhost)] Request Done- total:0.847,since last([newBlog(Domain:h...):0.847]]
2020-09-26 12:58:09,538 |jsse-nio-8443-exec-6 |ControlServlet                |T| [[[editBlog(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:58:09,571 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.0s, 5 requests, 3 views in file:/C:/projectsASF/Git/ofbiz-framework/plugins/lucene/webapp/content/WEB-INF/controller.xml
2020-09-26 12:58:09,592 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.004s, 379 requests, 154 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/content/webapp/content/WEB-INF/controller.xml
2020-09-26 12:58:09,608 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.0s, 48 requests, 22 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/common-controller.xml
2020-09-26 12:58:09,622 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/handlers-controller.xml
2020-09-26 12:58:09,636 |jsse-nio-8443-exec-6 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/webapp/WEB-INF/controller.xml
2020-09-26 12:58:09,640 |jsse-nio-8443-exec-6 |RequestHandler                |I| Rendering View [EditBlog].  Hidden sessionId by default.
2020-09-26 12:58:09,651 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 8 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/forum/BlogScreens.xml
2020-09-26 12:58:09,659 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 15 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/CommonScreens.xml
2020-09-26 12:58:09,665 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 1 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
2020-09-26 12:58:09,698 |jsse-nio-8443-exec-6 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [9] milliseconds
2020-09-26 12:58:09,708 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 27 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
2020-09-26 12:58:09,766 |jsse-nio-8443-exec-6 |ScreenFactory                 |I| Got 26 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common/widget/CommonScreens.xml
2020-09-26 12:58:09,876 |jsse-nio-8443-exec-6 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:58:09,877 |jsse-nio-8443-exec-6 |ControlServlet                |T| [[[editBlog(Domain:https://localhost)] Request Done- total:0.339,since last([editBlog(Domain:...):0.339]]
2020-09-26 12:58:14,677 |jsse-nio-8443-exec-8 |ControlServlet                |T| [[[blogContent(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:58:14,683 |jsse-nio-8443-exec-8 |RequestHandler                |I| Rendering View [blogContent].  Hidden sessionId by default.
2020-09-26 12:58:14,684 |jsse-nio-8443-exec-8 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [1] milliseconds
2020-09-26 12:58:14,699 |jsse-nio-8443-exec-8 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [1] milliseconds
2020-09-26 12:58:14,749 |jsse-nio-8443-exec-8 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:58:14,750 |jsse-nio-8443-exec-8 |ControlServlet                |T| [[[blogContent(Domain:https://localhost)] Request Done- total:0.073,since last([blogContent(Doma...):0.073]]
2020-09-26 12:58:17,690 |jsse-nio-8443-exec-9 |ControlServlet                |T| [[[EditBlogArticle(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:58:17,695 |jsse-nio-8443-exec-9 |RequestHandler                |I| Rendering View [EditBlogArticle].  Hidden sessionId by default.
2020-09-26 12:58:17,713 |jsse-nio-8443-exec-9 |ServiceDispatcher             |T| Sync service [lucene/getBlogEntry] finished in [16] milliseconds
2020-09-26 12:58:17,716 |jsse-nio-8443-exec-9 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [1] milliseconds
2020-09-26 12:58:17,756 |jsse-nio-8443-exec-9 |ContentWorker                 |W| No sub-content found with map-key [IMAGE] for content []
2020-09-26 12:58:17,834 |jsse-nio-8443-exec-9 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:58:17,834 |jsse-nio-8443-exec-9 |ControlServlet                |T| [[[EditBlogArticle(Domain:https://localhost)] Request Done- total:0.144,since last([EditBlogArticle(...):0.144]]
2020-09-26 12:58:29,320 |jsse-nio-8443-exec-2 |ControlServlet                |T| [[[createBlogArticle(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
2020-09-26 12:58:29,334 |jsse-nio-8443-exec-2 |ConfigXMLReader               |I| controller loaded: 0.0s, 5 requests, 3 views in file:/C:/projectsASF/Git/ofbiz-framework/plugins/lucene/webapp/content/WEB-INF/controller.xml
2020-09-26 12:58:29,355 |jsse-nio-8443-exec-2 |ConfigXMLReader               |I| controller loaded: 0.003s, 379 requests, 154 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/content/webapp/content/WEB-INF/controller.xml
2020-09-26 12:58:29,370 |jsse-nio-8443-exec-2 |ConfigXMLReader               |I| controller loaded: 0.0s, 48 requests, 22 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/common-controller.xml
2020-09-26 12:58:29,383 |jsse-nio-8443-exec-2 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/framework/common/webcommon/WEB-INF/handlers-controller.xml
2020-09-26 12:58:29,397 |jsse-nio-8443-exec-2 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/webapp/WEB-INF/controller.xml
2020-09-26 12:58:29,425 |jsse-nio-8443-exec-2 |ModelService                  |I| Set default value [DOCUMENT] for parameter [contentTypeId]
2020-09-26 12:58:29,442 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,442 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,442 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [17] milliseconds
2020-09-26 12:58:29,455 |jsse-nio-8443-exec-2 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: Content
2020-09-26 12:58:29,489 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [33] milliseconds
2020-09-26 12:58:29,489 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,489 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [roleTypeId][is-not-empty][true][String]
2020-09-26 12:58:29,489 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,489 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentRole, triggered by rule on Service: createContent
2020-09-26 12:58:29,491 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,491 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / 10001] completed; returning hasPermission = true
2020-09-26 12:58:29,491 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [1] milliseconds
2020-09-26 12:58:29,492 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: ensurePartyRole, triggered by rule on Service: createContentRole
2020-09-26 12:58:29,503 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/ensurePartyRole] finished in [11] milliseconds
2020-09-26 12:58:29,503 |jsse-nio-8443-exec-2 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:ContentRole][contentId,10001(java.lang.String)][fromDate,null()][partyId,admin(j
ava.lang.String)][roleTypeId,OWNER(java.lang.String)]
2020-09-26 12:58:29,506 |jsse-nio-8443-exec-2 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: ContentRole
2020-09-26 12:58:29,514 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [8] milliseconds
2020-09-26 12:58:29,514 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentRole] finished in [24] milliseconds
2020-09-26 12:58:29,514 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [partyId][is-empty][true][String]
2020-09-26 12:58:29,514 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (contentIdTo) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,514 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [contentIdTo][is-not-empty][true][String]
2020-09-26 12:58:29,514 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentAssoc, triggered by rule on Service: createContent
2020-09-26 12:58:29,516 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_UPDATE
2020-09-26 12:58:29,516 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [UPDATE / 10000] completed; returning hasPermission = true
2020-09-26 12:58:29,516 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [1] milliseconds
2020-09-26 12:58:29,521 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentAssoc] finished in [6] milliseconds
2020-09-26 12:58:29,521 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (contentPurposeTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,521 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [contentPurposeTypeId][is-not-empty][true][String]
2020-09-26 12:58:29,521 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContent] finished in [96] milliseconds
2020-09-26 12:58:29,554 |jsse-nio-8443-exec-2 |UtilProperties                |I| ResourceBundle DefaultMessagesUiLabels (fr) created in 0.033s with 3 properties
2020-09-26 12:58:29,554 |jsse-nio-8443-exec-2 |Log                           |I| [BlogServices.xml#createBlogEntry line 94] calling createTextContent with map: {contentPurposeTypeId=ARTICLE, textData=test, dataTemplateTypeId=NONE, status
Id=CTNT_INITIAL_DRAFT, ownerContentId=10000, contentAssocTypeId=SUB_CONTENT, mapKey=ARTICLE, contentIdFrom=10001, description=test, partyId=admin, dataResourceTypeId=ELECTRONIC_TEXT, contentName=test}
2020-09-26 12:58:29,555 |jsse-nio-8443-exec-2 |ModelService                  |I| Set default value [DOCUMENT] for parameter [contentTypeId]
2020-09-26 12:58:29,555 |jsse-nio-8443-exec-2 |GroupServiceModel             |I| Running grouped service [createDataText]
2020-09-26 12:58:29,556 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createElectronicText, triggered by rule on Service: createDataText
2020-09-26 12:58:29,570 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 69] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,570 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 73] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,570 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericDataResourcePermission] finished in [14] milliseconds
2020-09-26 12:58:29,570 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (dataResourceId) is not found in context for createElectronicText, defaulting to null.
2020-09-26 12:58:29,570 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createDataResource, triggered by rule on Service: createElectronicText
2020-09-26 12:58:29,572 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 69] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,572 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 73] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,572 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericDataResourcePermission] finished in [2] milliseconds
2020-09-26 12:58:29,612 |jsse-nio-8443-exec-2 |SequenceUtil                  |W| Lock failed; no sequence row was found, will try to add a new one for sequence: DataResource
2020-09-26 12:58:29,618 |jsse-nio-8443-exec-2 |SequenceUtil                  |I| Got bank of sequenced IDs for [DataResource]; curSeqId=10000, maxSeqId=10010, bankSize=10
2020-09-26 12:58:29,637 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createDataResource, defaulting to null.
2020-09-26 12:58:29,637 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataResource] on [commit] got false for condition: [roleTypeId][is-not-empty][true][String]
2020-09-26 12:58:29,638 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createDataResource, defaulting to null.
2020-09-26 12:58:29,638 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createDataResourceRole, triggered by rule on Service: createDataResource
2020-09-26 12:58:29,639 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 69] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,639 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 73] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,639 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericDataResourcePermission] finished in [1] milliseconds
2020-09-26 12:58:29,639 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: ensurePartyRole, triggered by rule on Service: createDataResourceRole
2020-09-26 12:58:29,645 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createDataResourceRole] finished in [7] milliseconds
2020-09-26 12:58:29,657 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataResource] on [commit] got false for condition: [partyId][is-empty][true][String]
2020-09-26 12:58:29,657 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createDataResource] finished in [87] milliseconds
2020-09-26 12:58:29,666 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createElectronicText] finished in [110] milliseconds
2020-09-26 12:58:29,666 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][is-empty][true][String]
2020-09-26 12:58:29,666 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][equals][SHORT_TEXT][true][String]
2020-09-26 12:58:29,666 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][is-empty][true][String]
2020-09-26 12:58:29,666 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][not-equals][ELECTRONIC_TEXT][true][String]
2020-09-26 12:58:29,666 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createDataText] finished in [111] milliseconds
2020-09-26 12:58:29,666 |jsse-nio-8443-exec-2 |GroupServiceModel             |I| Running grouped service [createContent]
2020-09-26 12:58:29,667 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,667 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,667 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [1] milliseconds
2020-09-26 12:58:29,677 |jsse-nio-8443-exec-2 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: Content
2020-09-26 12:58:29,702 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [25] milliseconds
2020-09-26 12:58:29,702 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,702 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [roleTypeId][is-not-empty][true][String]
2020-09-26 12:58:29,702 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,702 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentRole, triggered by rule on Service: createContent
2020-09-26 12:58:29,703 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,703 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / 10002] completed; returning hasPermission = true
2020-09-26 12:58:29,703 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: ensurePartyRole, triggered by rule on Service: createContentRole
2020-09-26 12:58:29,704 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/ensurePartyRole] finished in [1] milliseconds
2020-09-26 12:58:29,704 |jsse-nio-8443-exec-2 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:ContentRole][contentId,10002(java.lang.String)][fromDate,null()][partyId,admin(j
ava.lang.String)][roleTypeId,OWNER(java.lang.String)]
2020-09-26 12:58:29,704 |jsse-nio-8443-exec-2 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: ContentRole
2020-09-26 12:58:29,712 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [8] milliseconds
2020-09-26 12:58:29,712 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentRole] finished in [10] milliseconds
2020-09-26 12:58:29,712 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [partyId][is-empty][true][String]
2020-09-26 12:58:29,712 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (contentIdTo) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,712 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [contentIdTo][is-not-empty][true][String]
2020-09-26 12:58:29,712 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentAssoc, triggered by rule on Service: createContent
2020-09-26 12:58:29,713 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_UPDATE
2020-09-26 12:58:29,713 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [UPDATE / 10001] completed; returning hasPermission = true
2020-09-26 12:58:29,713 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericContentPermission] finished in [1] milliseconds
2020-09-26 12:58:29,721 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentAssoc] finished in [9] milliseconds
2020-09-26 12:58:29,721 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentPurpose, triggered by rule on Service: createContent
2020-09-26 12:58:29,722 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/contentManagerPermission] finished in [1] milliseconds
2020-09-26 12:58:29,741 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentPurpose] finished in [20] milliseconds
2020-09-26 12:58:29,741 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContent] finished in [75] milliseconds
2020-09-26 12:58:29,742 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createTextContent] finished in [188] milliseconds
2020-09-26 12:58:29,743 |jsse-nio-8443-exec-2 |ModelService                  |I| Set default value [DOCUMENT] for parameter [contentTypeId]
2020-09-26 12:58:29,743 |jsse-nio-8443-exec-2 |GroupServiceModel             |I| Running grouped service [createDataText]
2020-09-26 12:58:29,744 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createElectronicText, triggered by rule on Service: createDataText
2020-09-26 12:58:29,745 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 69] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,745 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 73] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,745 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericDataResourcePermission] finished in [1] milliseconds
2020-09-26 12:58:29,745 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (dataResourceId) is not found in context for createElectronicText, defaulting to null.
2020-09-26 12:58:29,745 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createDataResource, triggered by rule on Service: createElectronicText
2020-09-26 12:58:29,746 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 69] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,746 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 73] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,747 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericDataResourcePermission] finished in [1] milliseconds
2020-09-26 12:58:29,754 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createDataResource, defaulting to null.
2020-09-26 12:58:29,754 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataResource] on [commit] got false for condition: [roleTypeId][is-not-empty][true][String]
2020-09-26 12:58:29,754 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createDataResource, defaulting to null.
2020-09-26 12:58:29,754 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createDataResourceRole, triggered by rule on Service: createDataResource
2020-09-26 12:58:29,755 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 69] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,755 |jsse-nio-8443-exec-2 |Log                           |I| [DataResourcePermissionServices.xml#genericDataResourcePermission line 73] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,755 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/genericDataResourcePermission] finished in [1] milliseconds
2020-09-26 12:58:29,755 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: ensurePartyRole, triggered by rule on Service: createDataResourceRole
2020-09-26 12:58:29,756 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createDataResourceRole] finished in [2] milliseconds
2020-09-26 12:58:29,756 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataResource] on [commit] got false for condition: [partyId][is-empty][true][String]
2020-09-26 12:58:29,756 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createDataResource] finished in [10] milliseconds
2020-09-26 12:58:29,759 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createElectronicText] finished in [15] milliseconds
2020-09-26 12:58:29,759 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][is-empty][true][String]
2020-09-26 12:58:29,759 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][equals][SHORT_TEXT][true][String]
2020-09-26 12:58:29,759 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][is-empty][true][String]
2020-09-26 12:58:29,759 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createDataText] on [invoke] got false for condition: [dataResourceTypeId][not-equals][ELECTRONIC_TEXT][true][String]
2020-09-26 12:58:29,759 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createDataText] finished in [16] milliseconds
2020-09-26 12:58:29,759 |jsse-nio-8443-exec-2 |GroupServiceModel             |I| Running grouped service [createContent]
2020-09-26 12:58:29,760 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,760 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / ] completed; returning hasPermission = true
2020-09-26 12:58:29,768 |jsse-nio-8443-exec-2 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: Content
2020-09-26 12:58:29,790 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [22] milliseconds
2020-09-26 12:58:29,790 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,790 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [roleTypeId][is-not-empty][true][String]
2020-09-26 12:58:29,790 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (roleTypeId) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,790 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentRole, triggered by rule on Service: createContent
2020-09-26 12:58:29,791 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_CREATE
2020-09-26 12:58:29,791 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [CREATE / 10003] completed; returning hasPermission = true
2020-09-26 12:58:29,792 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: ensurePartyRole, triggered by rule on Service: createContentRole
2020-09-26 12:58:29,792 |jsse-nio-8443-exec-2 |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:ContentRole][contentId,10003(java.lang.String)][fromDate,null()][partyId,admin(j
ava.lang.String)][roleTypeId,OWNER(java.lang.String)]
2020-09-26 12:58:29,812 |jsse-nio-8443-exec-2 |EntityEcaRule                 |I| Running Entity ECA Service: indexContentKeywords, triggered by rule on Entity: ContentRole
2020-09-26 12:58:29,815 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [entity-default/indexContentKeywords] finished in [3] milliseconds
2020-09-26 12:58:29,816 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentRole] finished in [24] milliseconds
2020-09-26 12:58:29,816 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [partyId][is-empty][true][String]
2020-09-26 12:58:29,816 |jsse-nio-8443-exec-2 |ServiceEcaCondition           |I| From Field (contentIdTo) is not found in context for createContent, defaulting to null.
2020-09-26 12:58:29,816 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| For Service ECA [createContent] on [commit] got false for condition: [contentIdTo][is-not-empty][true][String]
2020-09-26 12:58:29,816 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentAssoc, triggered by rule on Service: createContent
2020-09-26 12:58:29,816 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 101] Admin permission found: CONTENTMGR_UPDATE
2020-09-26 12:58:29,816 |jsse-nio-8443-exec-2 |Log                           |I| [ContentPermissionServices.xml#genericContentPermission line 105] Permission service [UPDATE / 10001] completed; returning hasPermission = true
2020-09-26 12:58:29,821 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentAssoc] finished in [5] milliseconds
2020-09-26 12:58:29,821 |jsse-nio-8443-exec-2 |ServiceEcaRule                |I| Running Service ECA Service: createContentPurpose, triggered by rule on Service: createContent
2020-09-26 12:58:29,822 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/contentManagerPermission] finished in [1] milliseconds
2020-09-26 12:58:29,881 |jsse-nio-8443-exec-2 |UtilProperties                |I| ResourceBundle ServiceErrorUiLabels (fr) created in 0.058s with 9 properties
2020-09-26 12:58:29,881 |jsse-nio-8443-exec-2 |ServiceUtil                   |E| {errorMessage=La valeur a �t� trouv�e (avec les r�fs. 10001::ARTICLE), une nouvelle ne peut donc pas �tre cr��e, responseMessage=error}
2020-09-26 12:58:29,881 |jsse-nio-8443-exec-2 |ServiceDispatcher             |E| Error in Service [createContentPurpose]: La valeur a �t� trouv�e (avec les r�fs. 10001::ARTICLE), une nouvelle ne peut donc pas �tre cr��e
2020-09-26 12:58:29,881 |jsse-nio-8443-exec-2 |TransactionUtil               |W| Calling transaction setRollbackOnly; this stack trace shows where this is happening:
java.lang.Exception: Error in Service [createContentPurpose]: La valeur a �t� trouv�e (avec les r�fs. 10001::ARTICLE), une nouvelle ne peut donc pas �tre cr��e
        at org.apache.ofbiz.entity.transaction.TransactionUtil.setRollbackOnly(TransactionUtil.java:359) [ofbiz.jar:?]
 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:293) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:547) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) [ofbiz.jar:?]
        at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) [ofbiz.jar:?]
 at org.apache.ofbiz.service.eca.ServiceEcaAction.runAction(ServiceEcaAction.java:128) [ofbiz.jar:?]
    at org.apache.ofbiz.service.eca.ServiceEcaRule.eval(ServiceEcaRule.java:160) [ofbiz.jar:?]
     at org.apache.ofbiz.service.eca.ServiceEcaUtil.evalRules(ServiceEcaUtil.java:195) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:502) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) [ofbiz.jar:?]
        at org.apache.ofbiz.service.group.GroupServiceModel.invoke(GroupServiceModel.java:119) [ofbiz.jar:?]
   at org.apache.ofbiz.service.group.GroupModel.runAll(GroupModel.java:167) [ofbiz.jar:?]
 at org.apache.ofbiz.service.group.GroupModel.run(GroupModel.java:130) [ofbiz.jar:?]
    at org.apache.ofbiz.service.group.ServiceGroupEngine.runSync(ServiceGroupEngine.java:54) [ofbiz.jar:?]
 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:403) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) [ofbiz.jar:?]
        at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:103) [ofbiz.jar:?]
        at org.apache.ofbiz.minilang.method.callops.CallService.exec(CallService.java:217) [ofbiz.jar:?]
       at org.apache.ofbiz.minilang.SimpleMethod.runSubOps(SimpleMethod.java:310) [ofbiz.jar:?]
       at org.apache.ofbiz.minilang.method.ifops.IfNotEmpty.exec(IfNotEmpty.java:61) [ofbiz.jar:?]
    at org.apache.ofbiz.minilang.SimpleMethod.runSubOps(SimpleMethod.java:310) [ofbiz.jar:?]
       at org.apache.ofbiz.minilang.method.ifops.IfNotEmpty.exec(IfNotEmpty.java:61) [ofbiz.jar:?]
    at org.apache.ofbiz.minilang.SimpleMethod.runSubOps(SimpleMethod.java:310) [ofbiz.jar:?]
       at org.apache.ofbiz.minilang.SimpleMethod.exec(SimpleMethod.java:457) [ofbiz.jar:?]
    at org.apache.ofbiz.minilang.SimpleMethod.runSimpleMethod(SimpleMethod.java:274) [ofbiz.jar:?]
 at org.apache.ofbiz.minilang.SimpleMethod.runSimpleService(SimpleMethod.java:293) [ofbiz.jar:?]
        at org.apache.ofbiz.minilang.SimpleServiceEngine.serviceInvoker(SimpleServiceEngine.java:79) [ofbiz.jar:?]
     at org.apache.ofbiz.minilang.SimpleServiceEngine.runSync(SimpleServiceEngine.java:48) [ofbiz.jar:?]
    at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:403) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) [ofbiz.jar:?]
        at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) [ofbiz.jar:?]
 at org.apache.ofbiz.webapp.event.ServiceEventHandler.invoke(ServiceEventHandler.java:246) [ofbiz.jar:?]
        at org.apache.ofbiz.webapp.control.RequestHandler.runEvent(RequestHandler.java:743) [ofbiz.jar:?]
      at org.apache.ofbiz.webapp.control.RequestHandler.doRequest(RequestHandler.java:467) [ofbiz.jar:?]
     at org.apache.ofbiz.webapp.control.ControlServlet.doGet(ControlServlet.java:217) [ofbiz.jar:?]
 at org.apache.ofbiz.webapp.control.ControlServlet.doPost(ControlServlet.java:91) [ofbiz.jar:?]
 at javax.servlet.http.HttpServlet.service(HttpServlet.java:706) [javax.servlet-api-4.0.0.jar:4.0.0]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:791) [javax.servlet-api-4.0.0.jar:4.0.0]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53) [tomcat-embed-websocket-9.0.31.jar:9.0.31]
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.SameSiteFilter.doFilter(SameSiteFilter.java:44) [ofbiz.jar:?]
       at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ContextFilter.doFilter(ContextFilter.java:191) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ControlFilter.doFilter(ControlFilter.java:157) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96) [tomcat-catalina-9.0.36.jar:9.0.36]
      at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541) [tomcat-catalina-9.0.36.jar:9.0.36]
  at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:139) [tomcat-catalina-9.0.36.jar:9.0.36]
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92) [tomcat-catalina-9.0.36.jar:9.0.36]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) [tomcat-catalina-9.0.36.jar:9.0.36]
        at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:690) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:373) [tomcat-coyote-9.0.36.jar:9.0.36]
        at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65) [tomcat-coyote-9.0.36.jar:9.0.36]
  at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868) [tomcat-coyote-9.0.36.jar:9.0.36]
   at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590) [tomcat-coyote-9.0.36.jar:9.0.36]
       at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) [tomcat-coyote-9.0.36.jar:9.0.36]
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_202]
       at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_202]
       at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-util-9.0.36.jar:9.0.36]
  at java.lang.Thread.run(Thread.java:748) [?:1.8.0_202]
2020-09-26 12:58:29,884 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContentPurpose] finished in [63] milliseconds
2020-09-26 12:58:29,885 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createContent] finished in [125] milliseconds
2020-09-26 12:58:29,885 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/createTextContent] finished in [142] milliseconds
2020-09-26 12:58:29,928 |jsse-nio-8443-exec-2 |TransactionUtil               |E| Rollback Only was set when trying to commit transaction here; throwing rollbackOnly cause exception
javax.transaction.RollbackException: Unable to commit: transaction marked for rollback
 at org.apache.geronimo.transaction.manager.TransactionImpl.commit(TransactionImpl.java:272) ~[geronimo-transaction-3.1.4.jar:3.1.4]
    at org.apache.geronimo.transaction.manager.TransactionManagerImpl.commit(TransactionManagerImpl.java:252) ~[geronimo-transaction-3.1.4.jar:3.1.4]
      at org.apache.ofbiz.entity.transaction.TransactionUtil.commit(TransactionUtil.java:241) [ofbiz.jar:?]
  at org.apache.ofbiz.entity.transaction.TransactionUtil.commit(TransactionUtil.java:227) [ofbiz.jar:?]
  at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:554) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) [ofbiz.jar:?]
        at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) [ofbiz.jar:?]
 at org.apache.ofbiz.webapp.event.ServiceEventHandler.invoke(ServiceEventHandler.java:246) [ofbiz.jar:?]
        at org.apache.ofbiz.webapp.control.RequestHandler.runEvent(RequestHandler.java:743) [ofbiz.jar:?]
      at org.apache.ofbiz.webapp.control.RequestHandler.doRequest(RequestHandler.java:467) [ofbiz.jar:?]
     at org.apache.ofbiz.webapp.control.ControlServlet.doGet(ControlServlet.java:217) [ofbiz.jar:?]
 at org.apache.ofbiz.webapp.control.ControlServlet.doPost(ControlServlet.java:91) [ofbiz.jar:?]
 at javax.servlet.http.HttpServlet.service(HttpServlet.java:706) [javax.servlet-api-4.0.0.jar:4.0.0]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:791) [javax.servlet-api-4.0.0.jar:4.0.0]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53) [tomcat-embed-websocket-9.0.31.jar:9.0.31]
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.SameSiteFilter.doFilter(SameSiteFilter.java:44) [ofbiz.jar:?]
       at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ContextFilter.doFilter(ContextFilter.java:191) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ControlFilter.doFilter(ControlFilter.java:157) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96) [tomcat-catalina-9.0.36.jar:9.0.36]
      at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541) [tomcat-catalina-9.0.36.jar:9.0.36]
  at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:139) [tomcat-catalina-9.0.36.jar:9.0.36]
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92) [tomcat-catalina-9.0.36.jar:9.0.36]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) [tomcat-catalina-9.0.36.jar:9.0.36]
        at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:690) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:373) [tomcat-coyote-9.0.36.jar:9.0.36]
        at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65) [tomcat-coyote-9.0.36.jar:9.0.36]
  at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868) [tomcat-coyote-9.0.36.jar:9.0.36]
   at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590) [tomcat-coyote-9.0.36.jar:9.0.36]
       at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) [tomcat-coyote-9.0.36.jar:9.0.36]
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_202]
       at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_202]
       at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-util-9.0.36.jar:9.0.36]
  at java.lang.Thread.run(Thread.java:748) [?:1.8.0_202]
Caused by: org.apache.geronimo.transaction.manager.SetRollbackOnlyException: setRollbackOnly() called.  See stacktrace for origin
       at org.apache.geronimo.transaction.manager.TransactionImpl.setRollbackOnly(TransactionImpl.java:126) ~[geronimo-transaction-3.1.4.jar:3.1.4]
   at org.apache.geronimo.transaction.manager.TransactionManagerImpl.setRollbackOnly(TransactionManagerImpl.java:243) ~[geronimo-transaction-3.1.4.jar:3.1.4]
     at org.apache.ofbiz.entity.transaction.TransactionUtil.setRollbackOnly(TransactionUtil.java:361) ~[ofbiz.jar:?]
        at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:293) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:547) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~[ofbiz.jar:?]
        at org.apache.ofbiz.service.eca.ServiceEcaAction.runAction(ServiceEcaAction.java:128) ~[ofbiz.jar:?]
   at org.apache.ofbiz.service.eca.ServiceEcaRule.eval(ServiceEcaRule.java:160) ~[ofbiz.jar:?]
    at org.apache.ofbiz.service.eca.ServiceEcaUtil.evalRules(ServiceEcaUtil.java:195) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:502) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.group.GroupServiceModel.invoke(GroupServiceModel.java:119) ~[ofbiz.jar:?]
  at org.apache.ofbiz.service.group.GroupModel.runAll(GroupModel.java:167) ~[ofbiz.jar:?]
        at org.apache.ofbiz.service.group.GroupModel.run(GroupModel.java:130) ~[ofbiz.jar:?]
   at org.apache.ofbiz.service.group.ServiceGroupEngine.runSync(ServiceGroupEngine.java:54) ~[ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:403) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:103) ~[ofbiz.jar:?]
       at org.apache.ofbiz.minilang.method.callops.CallService.exec(CallService.java:217) ~[ofbiz.jar:?]
      at org.apache.ofbiz.minilang.SimpleMethod.runSubOps(SimpleMethod.java:310) ~[ofbiz.jar:?]
      at org.apache.ofbiz.minilang.method.ifops.IfNotEmpty.exec(IfNotEmpty.java:61) ~[ofbiz.jar:?]
   at org.apache.ofbiz.minilang.SimpleMethod.runSubOps(SimpleMethod.java:310) ~[ofbiz.jar:?]
      at org.apache.ofbiz.minilang.method.ifops.IfNotEmpty.exec(IfNotEmpty.java:61) ~[ofbiz.jar:?]
   at org.apache.ofbiz.minilang.SimpleMethod.runSubOps(SimpleMethod.java:310) ~[ofbiz.jar:?]
      at org.apache.ofbiz.minilang.SimpleMethod.exec(SimpleMethod.java:457) ~[ofbiz.jar:?]
   at org.apache.ofbiz.minilang.SimpleMethod.runSimpleMethod(SimpleMethod.java:274) ~[ofbiz.jar:?]
        at org.apache.ofbiz.minilang.SimpleMethod.runSimpleService(SimpleMethod.java:293) ~[ofbiz.jar:?]
       at org.apache.ofbiz.minilang.SimpleServiceEngine.serviceInvoker(SimpleServiceEngine.java:79) ~[ofbiz.jar:?]
    at org.apache.ofbiz.minilang.SimpleServiceEngine.runSync(SimpleServiceEngine.java:48) ~[ofbiz.jar:?]
   at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:403) ~[ofbiz.jar:?]
       ... 40 more
2020-09-26 12:58:29,929 |jsse-nio-8443-exec-2 |ServiceDispatcher             |E| Could not commit transaction for service [createBlogEntry] call
org.apache.ofbiz.entity.transaction.GenericTransactionException: Roll back error, could not commit transaction, was rolled back instead because of: Error in Service [createContentPurpose]: La valeur a �t� trouv�e (avec les r�fs. 10001::A
RTICLE), une nouvelle ne peut donc pas �tre cr��e
 at org.apache.ofbiz.entity.transaction.TransactionUtil.commit(TransactionUtil.java:263) ~[ofbiz.jar:?]
 at org.apache.ofbiz.entity.transaction.TransactionUtil.commit(TransactionUtil.java:227) ~[ofbiz.jar:?]
 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:554) [ofbiz.jar:?]
        at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) [ofbiz.jar:?]
        at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) [ofbiz.jar:?]
 at org.apache.ofbiz.webapp.event.ServiceEventHandler.invoke(ServiceEventHandler.java:246) [ofbiz.jar:?]
        at org.apache.ofbiz.webapp.control.RequestHandler.runEvent(RequestHandler.java:743) [ofbiz.jar:?]
      at org.apache.ofbiz.webapp.control.RequestHandler.doRequest(RequestHandler.java:467) [ofbiz.jar:?]
     at org.apache.ofbiz.webapp.control.ControlServlet.doGet(ControlServlet.java:217) [ofbiz.jar:?]
 at org.apache.ofbiz.webapp.control.ControlServlet.doPost(ControlServlet.java:91) [ofbiz.jar:?]
 at javax.servlet.http.HttpServlet.service(HttpServlet.java:706) [javax.servlet-api-4.0.0.jar:4.0.0]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:791) [javax.servlet-api-4.0.0.jar:4.0.0]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53) [tomcat-embed-websocket-9.0.31.jar:9.0.31]
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.SameSiteFilter.doFilter(SameSiteFilter.java:44) [ofbiz.jar:?]
       at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ContextFilter.doFilter(ContextFilter.java:191) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ControlFilter.doFilter(ControlFilter.java:157) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96) [tomcat-catalina-9.0.36.jar:9.0.36]
      at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541) [tomcat-catalina-9.0.36.jar:9.0.36]
  at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:139) [tomcat-catalina-9.0.36.jar:9.0.36]
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92) [tomcat-catalina-9.0.36.jar:9.0.36]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) [tomcat-catalina-9.0.36.jar:9.0.36]
        at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:690) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:373) [tomcat-coyote-9.0.36.jar:9.0.36]
        at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65) [tomcat-coyote-9.0.36.jar:9.0.36]
  at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868) [tomcat-coyote-9.0.36.jar:9.0.36]
   at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590) [tomcat-coyote-9.0.36.jar:9.0.36]
       at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) [tomcat-coyote-9.0.36.jar:9.0.36]
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_202]
       at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_202]
       at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-util-9.0.36.jar:9.0.36]
  at java.lang.Thread.run(Thread.java:748) [?:1.8.0_202]
2020-09-26 12:58:29,930 |jsse-nio-8443-exec-2 |ServiceEventHandler           |E| Service invocation error
org.apache.ofbiz.service.GenericServiceException: Could not commit transaction for service [createBlogEntry] call: Roll back error, could not commit transaction, was rolled back instead because of: Error in Service [createContentPurpose]
: La valeur a �t� trouv�e (avec les r�fs. 10001::ARTICLE), une nouvelle ne peut donc pas �tre cr��e
       at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:563) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:228) ~[ofbiz.jar:?]
       at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~[ofbiz.jar:?]
        at org.apache.ofbiz.webapp.event.ServiceEventHandler.invoke(ServiceEventHandler.java:246) [ofbiz.jar:?]
        at org.apache.ofbiz.webapp.control.RequestHandler.runEvent(RequestHandler.java:743) [ofbiz.jar:?]
      at org.apache.ofbiz.webapp.control.RequestHandler.doRequest(RequestHandler.java:467) [ofbiz.jar:?]
     at org.apache.ofbiz.webapp.control.ControlServlet.doGet(ControlServlet.java:217) [ofbiz.jar:?]
 at org.apache.ofbiz.webapp.control.ControlServlet.doPost(ControlServlet.java:91) [ofbiz.jar:?]
 at javax.servlet.http.HttpServlet.service(HttpServlet.java:706) [javax.servlet-api-4.0.0.jar:4.0.0]
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:791) [javax.servlet-api-4.0.0.jar:4.0.0]
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53) [tomcat-embed-websocket-9.0.31.jar:9.0.31]
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.SameSiteFilter.doFilter(SameSiteFilter.java:44) [ofbiz.jar:?]
       at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ContextFilter.doFilter(ContextFilter.java:191) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.ofbiz.webapp.control.ControlFilter.doFilter(ControlFilter.java:157) [ofbiz.jar:?]
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96) [tomcat-catalina-9.0.36.jar:9.0.36]
      at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:541) [tomcat-catalina-9.0.36.jar:9.0.36]
  at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:139) [tomcat-catalina-9.0.36.jar:9.0.36]
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92) [tomcat-catalina-9.0.36.jar:9.0.36]
    at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:74) [tomcat-catalina-9.0.36.jar:9.0.36]
        at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:690) [tomcat-catalina-9.0.36.jar:9.0.36]
       at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:343) [tomcat-catalina-9.0.36.jar:9.0.36]
     at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:373) [tomcat-coyote-9.0.36.jar:9.0.36]
        at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65) [tomcat-coyote-9.0.36.jar:9.0.36]
  at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:868) [tomcat-coyote-9.0.36.jar:9.0.36]
   at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1590) [tomcat-coyote-9.0.36.jar:9.0.36]
       at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) [tomcat-coyote-9.0.36.jar:9.0.36]
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_202]
       at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_202]
       at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) [tomcat-util-9.0.36.jar:9.0.36]
  at java.lang.Thread.run(Thread.java:748) [?:1.8.0_202]
                                                                                                                                                                                                                                            2
020-09-26 12:58:29,988 |jsse-nio-8443-exec-2 |UtilProperties                |I| ResourceBundle WebappUiLabels (fr) created in 0.057s with 25 properties
2020-09-26 12:58:29,988 |jsse-nio-8443-exec-2 |RequestHandler                |E| Request createBlogArticle caused an error with the following message: Erreur lors de l'appel de l'�v�nement: org.apache.ofbiz.webapp.event.EventHandlerExcep
tion: Service invocation error (Could not commit transaction for service [createBlogEntry] call: Roll back error, could not commit transaction, was rolled back instead because of: Error in Service [createContentPurpose]: La valeur a �t�
trouv�e (avec les r�fs. 10001::ARTICLE), une nouvelle ne peut donc pas �tre cr��e)
2020-09-26 12:58:29,989 |jsse-nio-8443-exec-2 |RequestHandler                |I| Rendering View [EditBlogArticle].  Hidden sessionId by default.
2020-09-26 12:58:29,990 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/getUserPreferenceGroup] finished in [1] milliseconds
2020-09-26 12:58:29,998 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 8 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/forum/BlogScreens.xml
2020-09-26 12:58:30,005 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 15 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/content/widget/CommonScreens.xml
2020-09-26 12:58:30,011 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 1 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
2020-09-26 12:58:30,056 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [lucene/getLastSystemInfoNote] finished in [10] milliseconds
2020-09-26 12:58:30,071 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 27 screens in 0.008s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
2020-09-26 12:58:30,130 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 26 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common/widget/CommonScreens.xml
2020-09-26 12:58:30,160 |jsse-nio-8443-exec-2 |ContentWorker                 |W| No sub-content found with map-key [IMAGE] for content []
2020-09-26 12:58:30,207 |jsse-nio-8443-exec-2 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
2020-09-26 12:58:30,225 |jsse-nio-8443-exec-2 |ControlServlet                |T| [[[createBlogArticle(Domain:https://localhost)] Request Done- total:0.905,since last([createBlogArticl...):0.905]]
> Building 97% > :ofbiz
{noformat}


> When creating blog or forums, it failed to save
> -----------------------------------------------
>
>                 Key: OFBIZ-10426
>                 URL: https://issues.apache.org/jira/browse/OFBIZ-10426
>             Project: OFBiz
>          Issue Type: Bug
>          Components: ecommerce
>    Affects Versions: Trunk
>            Reporter: Jason Hao
>            Assignee: Aman Mishra
>            Priority: Major
>         Attachments: OFBIZ-10426-R17-Article.png, OFBIZ-10426-R17-Blog.png, OFBIZ-10426-Working.png, blog-error.png
>
>
> Create a blog or forum and click save button, it will popup with error message. The reason is because the mapKey passed from front end cannot be handled by the service. The solution is not to pass the mapKey to the service.
> Steps:  
> 1) navigate to https://demo-trunk.ofbiz.apache.org/content/control/blogContent?blogContentId=BLOGROOTBIGAL
> 2) create a new article  https://demo-trunk.ofbiz.apache.org/content/control/EditBlogArticle?blogContentId=BLOGROOTBIGAL
>  
> ERROR: Could not complete the Post a new Content article Entry [file:/Users/explorer/Documents/ofbiz/ofbiz-framework/applications/content/minilang/content/ContentServices.xml#createArticleContent|file:///Users/explorer/Documents/ofbiz/ofbiz-framework/applications/content/minilang/content/ContentServices.xml#createArticleContent] process [problem invoking the [createTextContent] service with the map named [createText] containing [{userLogin=[GenericEntity:UserLogin][createdStamp,2018-06-01 21:38:24.088(java.sql.Timestamp)][createdTxStamp,2018-06-01 21:38:24.086(java.sql.Timestamp)][currentPassword,
> {SHA}
> 47b56994cbc2b6d10aa1be30f70165adb305a41a(java.lang.String)][disabledBy,null()][disabledDateTime,null()][enabled,Y(java.lang.String)][externalAuthId,null()][hasLoggedOut,N(java.lang.String)][isSystem,null()][lastCurrencyUom,null()][lastLocale,null()][lastTimeZone,Asia/Shanghai(java.lang.String)][lastUpdatedStamp,2018-06-02 03:00:52.632(java.sql.Timestamp)][lastUpdatedTxStamp,2018-06-02 03:00:52.632(java.sql.Timestamp)][partyId,admin(java.lang.String)][passwordHint,null()][requirePasswordChange,null()][successiveFailedLogins,0(java.lang.Long)][userLdapDn,null()][userLoginId,admin(java.lang.String)], textData=hello, dataTemplateTypeId=NONE, mapKey=MAIN, contentIdFrom=ASK, description=hello, partyId=admin, locale=en_US, dataResourceTypeId=ELECTRONIC_TEXT, contentName=hell world}]: Unknown parameter found: [createTextContent.contentIdFrom]Unknown parameter found: [createTextContent.mapKey]]
>  



--
This message was sent by Atlassian Jira
(v8.3.4#803005)