Details

    • Bug
    • Status: Reopened
    • Major
    • Resolution: Unresolved
    • Upcoming Branch
    • Upcoming Branch
    • manufacturing
    • None

    Description

      I'm working with the Manufacturing tutorial on Sharan's book - making tables with wood, nails and varnish - when I run the MRP and as guided I got the authentication error that - when searched - found that this was reported before in the following thread but unfortunately when I applied the workaround - noticed that the problem still there in the online demo - it didn't work for me and I got the following error message which is not describing exactly what is happening as I entered the 'facilityId' in the params. 
       
      facilityId and facilityGroupId cannot be both null

      Attachments

        1. Image 019.png
          34 kB
          Jacques Le Roux
        2. Image 020.png
          17 kB
          Jacques Le Roux
        3. Image 021.png
          52 kB
          Jacques Le Roux
        4. OFBIZ-12745-revert.patch
          18 kB
          Jacques Le Roux
        5. Screenshot 2024-07-22 at 8.41.00 PM.png
          460 kB
          Emad Radwan
        6. Screenshot 2024-07-22 at 8.41.00 PM-1.png
          460 kB
          Emad Radwan
        7. Screenshot 2024-07-22 at 8.43.27 PM.png
          1.13 MB
          Emad Radwan
        8. Screenshot 2024-07-22 at 8.43.27 PM-1.png
          1.13 MB
          Emad Radwan
        9. Screenshot 2024-07-23 at 8.49.52 PM (2).png
          227 kB
          Emad Radwan
        10. Screenshot 2024-07-23 at 8.49.52 PM (2)-1.png
          227 kB
          Emad Radwan
        11. Screenshot 2024-07-25 at 5.32.13 PM (2).png
          170 kB
          Emad Radwan

        Issue Links

          Activity

            Thanks Emad,

            It would have been better with the thread you speak about
            Not a big deal, here it is: https://lists.apache.org/thread/78m526d74kzb40kkp3tmv04jb208581j

            I'll have a look as soon as I get a chance...

            jleroux Jacques Le Roux added a comment - Thanks Emad, It would have been better with the thread you speak about Not a big deal, here it is: https://lists.apache.org/thread/78m526d74kzb40kkp3tmv04jb208581j I'll have a look as soon as I get a chance...

            It works locally with 18.12 version (HEAD). The problem could be due to https://github.com/apache/ofbiz-framework/commit/a19807e136. That needs some investigation...

            jleroux Jacques Le Roux added a comment - It works locally with 18.12 version (HEAD). The problem could be due to https://github.com/apache/ofbiz-framework/commit/a19807e136 . That needs some investigation...

            It's actually due to OFBIZ-10395. Reverting the 3 commits there resolves the problem in trunk. I'll push soon...

            jleroux Jacques Le Roux added a comment - It's actually due to OFBIZ-10395 . Reverting the 3 commits there resolves the problem in trunk. I'll push soon...
            emad1967 Emad Radwan added a comment -

            Many thanks.

            On Fri, Jul 12, 2024 at 10:09 AM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - Many thanks. On Fri, Jul 12, 2024 at 10:09 AM Jacques Le Roux (Jira) <jira@apache.org>

            Commit 0c7a89e7c36daf84ff56f1612374144ba831c03f in ofbiz-framework's branch refs/heads/trunk from Jacques Le Roux
            [ https://gitbox.apache.org/repos/asf?p=ofbiz-framework.git;h=0c7a89e7c3 ]

            Fixed: Error with executeMRP service (OFBIZ-13122)

            Reverting OFBIZ-10395 commits was not enough because of the merge issues.
            Other things have changed since:

            • createRequirementCustRequest, was created later
            • Some service were migrated to groovy, eg checkCreateOrderRequirement
            • etc.

            Actually only adding again in the RequirementServices.xml the old
            createRequirement simple-method, with its required requirementInterface
            interface, to replace the entity-auto createRequirement service was needed.

            For history sake: also deleteRequirement is no longer required, the new Groovy
            implementation deleteRequirementAndRelated does really the work. Same for the
            rest of the file below.

            jira-bot ASF subversion and git services added a comment - Commit 0c7a89e7c36daf84ff56f1612374144ba831c03f in ofbiz-framework's branch refs/heads/trunk from Jacques Le Roux [ https://gitbox.apache.org/repos/asf?p=ofbiz-framework.git;h=0c7a89e7c3 ] Fixed: Error with executeMRP service ( OFBIZ-13122 ) Reverting OFBIZ-10395 commits was not enough because of the merge issues. Other things have changed since: createRequirementCustRequest, was created later Some service were migrated to groovy, eg checkCreateOrderRequirement etc. Actually only adding again in the RequirementServices.xml the old createRequirement simple-method, with its required requirementInterface interface, to replace the entity-auto createRequirement service was needed. For history sake: also deleteRequirement is no longer required, the new Groovy implementation deleteRequirementAndRelated does really the work. Same for the rest of the file below.
            emad1967 Emad Radwan added a comment -

            Hello Jacques,

            When do you think this fix will be available?

            Regards,
            Emad

            On Fri, Jul 12, 2024 at 9:01 PM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - Hello Jacques, When do you think this fix will be available? Regards, Emad On Fri, Jul 12, 2024 at 9:01 PM Jacques Le Roux (Jira) <jira@apache.org>
            jleroux Jacques Le Roux added a comment - - edited

            Hi Emad,

            What do you mean, it does not work for you? Which version are you using?

            jleroux Jacques Le Roux added a comment - - edited Hi Emad, What do you mean, it does not work for you? Which version are you using?
            emad1967 Emad Radwan added a comment -

            https://demo-stable.ofbiz.apache.org

            On Mon, Jul 22, 2024 at 12:21 PM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - https://demo-stable.ofbiz.apache.org On Mon, Jul 22, 2024 at 12:21 PM Jacques Le Roux (Jira) <jira@apache.org>
            emad1967 Emad Radwan added a comment -

            I'm not sure what you want me to see in the screenshot but I tried it again
            on the demo and truck versions and I get 'failed' production run from the
            'MRP' log after creating the mrp; here's the screenshots and I'll try to
            put them on Jira as well.

            Regards,
            Emad

            On Mon, Jul 22, 2024 at 8:26 PM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - I'm not sure what you want me to see in the screenshot but I tried it again on the demo and truck versions and I get 'failed' production run from the 'MRP' log after creating the mrp; here's the screenshots and I'll try to put them on Jira as well. Regards, Emad On Mon, Jul 22, 2024 at 8:26 PM Jacques Le Roux (Jira) <jira@apache.org>
            emad1967 Emad Radwan added a comment -

            emad1967 Emad Radwan added a comment -
            emad1967 Emad Radwan added a comment -

            emad1967 Emad Radwan added a comment -

            Using my local 18.12 HEAD version I again confirm it's working. Here are the proofs:

            Log

            2024-07-22 19:11:28,465 |jsse-nio-8443-exec-2 |ControlServlet                |T| [[[RunMrp(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
            2024-07-22 19:11:28,480 |jsse-nio-8443-exec-2 |ConfigXMLReader               |I| controller loaded: 0.002s, 149 requests, 66 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/webapp/manufacturing/WEB-INF/contro
            ller.xml
            2024-07-22 19:11:28,502 |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
            2024-07-22 19:11:28,514 |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
            2024-07-22 19:11:28,525 |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
            2024-07-22 19:11:28,526 |jsse-nio-8443-exec-2 |JWTManager                    |I| Internal single sign on is disabled.
            2024-07-22 19:11:28,530 |jsse-nio-8443-exec-2 |RequestHandler                |I| Rendering View [MrpExecution].  Hidden sessionId by default.
            2024-07-22 19:11:28,538 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 4 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/MrpScreens.xml
            2024-07-22 19:11:28,543 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 2 screens in 0.004s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/CommonScreens.xml
            2024-07-22 19:11:28,549 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 1 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
            2024-07-22 19:11:28,584 |jsse-nio-8443-exec-2 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [12] milliseconds
            2024-07-22 19:11:28,594 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 27 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
            2024-07-22 19:11:28,651 |jsse-nio-8443-exec-2 |ScreenFactory                 |I| Got 26 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common-theme/widget/CommonScreens.xml
            2024-07-22 19:11:28,744 |jsse-nio-8443-exec-2 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
            2024-07-22 19:11:28,745 |jsse-nio-8443-exec-2 |ControlServlet                |T| [[[RunMrp(Domain:https://localhost)] Request Done- total:0.28,since last([RunMrp(Domain:ht...):0.28]]
            2024-07-22 19:11:49,914 |jsse-nio-8443-exec-3 |LoginWorker                   |W| Received a null Security object from HttpServletRequest
            2024-07-22 19:11:49,914 |jsse-nio-8443-exec-3 |ControlServlet                |T| [[[runMrpGo(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
            2024-07-22 19:11:49,933 |jsse-nio-8443-exec-3 |ConfigXMLReader               |I| controller loaded: 0.002s, 149 requests, 66 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/webapp/manufacturing/WEB-INF/contro
            ller.xml
            2024-07-22 19:11:49,948 |jsse-nio-8443-exec-3 |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
            2024-07-22 19:11:49,959 |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
            2024-07-22 19:11:49,971 |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
            2024-07-22 19:11:49,972 |jsse-nio-8443-exec-3 |JWTManager                    |I| Internal single sign on is disabled.
            2024-07-22 19:11:49,977 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'manufacturing / executeMrp'
            2024-07-22 19:11:50,022 |jsse-nio-8443-exec-3 |GenericAsyncEngine            |I| Persisted job queued : 1721668310012
            2024-07-22 19:11:50,022 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| [[ASync service finished...- total:0.045,since last(ASync service sta...):0.045]] - 'manufacturing / executeMrp'
            2024-07-22 19:11:50,023 |jsse-nio-8443-exec-3 |RequestHandler                |I| Ran Event [service:async#executeMrp] from [request], result is [success]
            2024-07-22 19:11:50,024 |jsse-nio-8443-exec-3 |RequestHandler                |I| Rendering View [RunMrpGo].  Hidden sessionId by default.
            2024-07-22 19:11:50,025 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [1] milliseconds
            2024-07-22 19:11:50,033 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 4 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/MrpScreens.xml
            2024-07-22 19:11:50,067 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 2 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/CommonScreens.xml
            2024-07-22 19:11:50,073 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 1 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml
            2024-07-22 19:11:50,121 |jsse-nio-8443-exec-3 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [15] milliseconds
            2024-07-22 19:11:50,134 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 27 screens in 0.008s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
            2024-07-22 19:11:50,203 |jsse-nio-8443-exec-3 |ScreenFactory                 |I| Got 26 screens in 0.008s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common-theme/widget/CommonScreens.xml
            2024-07-22 19:11:50,310 |jsse-nio-8443-exec-3 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
            2024-07-22 19:11:50,312 |jsse-nio-8443-exec-3 |ControlServlet                |T| [[[runMrpGo(Domain:https://localhost)] Request Done- total:0.398,since last([runMrpGo(Domain:...):0.398]]
            2024-07-22 19:11:52,481 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [1721668310012] Id [16532] -- Next runtime: Thu Jan 01 00:59:59 CET 1970
            2024-07-22 19:11:52,514 |OFBiz-JobQueue-0     |MrpServices                   |I| executeMrp called
            2024-07-22 19:11:52,523 |OFBiz-JobQueue-0     |SequenceUtil                  |I| Got bank of sequenced IDs for [MrpEvent]; curSeqId=10040, maxSeqId=10050, bankSize=10
            2024-07-22 19:11:53,069 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [27] milliseconds
            2024-07-22 19:11:53,076 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [7] milliseconds
            2024-07-22 19:11:53,079 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds
            2024-07-22 19:11:53,081 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,085 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,087 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,090 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,091 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,093 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,094 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,096 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,097 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,099 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,102 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds
            2024-07-22 19:11:53,103 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,144 |OFBiz-JobQueue-0     |MrpServices                   |I| return from initMrpEvent
            2024-07-22 19:11:53,144 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/initMrpEvents] finished in [621] milliseconds
            2024-07-22 19:11:53,178 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds
            2024-07-22 19:11:53,265 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [24] milliseconds
            2024-07-22 19:11:53,316 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [51] milliseconds
            2024-07-22 19:11:53,316 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [137] milliseconds
            2024-07-22 19:11:53,321 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds
            2024-07-22 19:11:53,327 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,329 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [2] milliseconds
            2024-07-22 19:11:53,330 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds
            2024-07-22 19:11:53,333 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,338 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,340 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [2] milliseconds
            2024-07-22 19:11:53,340 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds
            2024-07-22 19:11:53,346 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,348 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [2] milliseconds
            2024-07-22 19:11:53,348 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds
            2024-07-22 19:11:53,385 |OFBiz-JobQueue-0     |SequenceUtil                  |I| Got bank of sequenced IDs for [Requirement]; curSeqId=10080, maxSeqId=10090, bankSize=10
            2024-07-22 19:11:53,385 |OFBiz-JobQueue-0     |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()]
            2024-07-22 19:11:53,454 |OFBiz-JobQueue-0     |UtilProperties                |I| ResourceBundle ServiceUiLabels (en) created in 0.044s with 4 properties
            2024-07-22 19:11:53,454 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String]
            2024-07-22 19:11:53,454 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null.
            2024-07-22 19:11:53,454 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String]
            2024-07-22 19:11:53,454 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,454 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,455 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service finished...- total:0.001,since last(ASync service sta...):0.001]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,455 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,506 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/autoAssignRequirementToSupplier] finished in [50] milliseconds
            2024-07-22 19:11:53,506 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/createRequirement] finished in [136] milliseconds
            2024-07-22 19:11:53,514 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds
            2024-07-22 19:11:53,523 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [3] milliseconds
            2024-07-22 19:11:53,528 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [4] milliseconds
            2024-07-22 19:11:53,528 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [13] milliseconds
            2024-07-22 19:11:53,532 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,534 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,534 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds
            2024-07-22 19:11:53,535 |OFBiz-JobQueue-0     |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()]
            2024-07-22 19:11:53,537 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String]
            2024-07-22 19:11:53,537 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null.
            2024-07-22 19:11:53,537 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String]
            2024-07-22 19:11:53,537 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,537 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,541 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service finished...- total:0.004,since last(ASync service sta...):0.004]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,541 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,542 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/autoAssignRequirementToSupplier] finished in [1] milliseconds
            2024-07-22 19:11:53,542 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/createRequirement] finished in [7] milliseconds
            2024-07-22 19:11:53,571 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds
            2024-07-22 19:11:53,577 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,579 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [2] milliseconds
            2024-07-22 19:11:53,579 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [7] milliseconds
            2024-07-22 19:11:53,583 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,586 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [3] milliseconds
            2024-07-22 19:11:53,586 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [7] milliseconds
            2024-07-22 19:11:53,588 |OFBiz-JobQueue-0     |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()]
            2024-07-22 19:11:53,589 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String]
            2024-07-22 19:11:53,589 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null.
            2024-07-22 19:11:53,589 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String]
            2024-07-22 19:11:53,589 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,589 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,589 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service finished...- total:0.0,since last(ASync service sta...):0.0]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,589 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,592 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/autoAssignRequirementToSupplier] finished in [3] milliseconds
            2024-07-22 19:11:53,592 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/createRequirement] finished in [5] milliseconds
            2024-07-22 19:11:53,615 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds
            2024-07-22 19:11:53,620 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,623 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [2] milliseconds
            2024-07-22 19:11:53,623 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [7] milliseconds
            2024-07-22 19:11:53,627 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [1] milliseconds
            2024-07-22 19:11:53,629 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getProductRouting] finished in [2] milliseconds
            2024-07-22 19:11:53,629 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds
            2024-07-22 19:11:53,630 |OFBiz-JobQueue-0     |PrimaryKeyFinder              |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()]
            2024-07-22 19:11:53,631 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String]
            2024-07-22 19:11:53,631 |OFBiz-JobQueue-0     |ServiceEcaCondition           |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null.
            2024-07-22 19:11:53,631 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String]
            2024-07-22 19:11:53,631 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,631 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,631 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[ASync service finished...- total:0.0,since last(ASync service sta...):0.0]] - 'default / createRequirementStatus'
            2024-07-22 19:11:53,631 |OFBiz-JobQueue-0     |ServiceEcaRule                |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement
            2024-07-22 19:11:53,633 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/autoAssignRequirementToSupplier] finished in [2] milliseconds
            2024-07-22 19:11:53,634 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/createRequirement] finished in [5] milliseconds
            2024-07-22 19:11:53,638 |OFBiz-JobQueue-0     |MrpServices                   |I| return from executeMrp
            2024-07-22 19:11:53,641 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| Sync service [default/executeMrp] finished in [1130] milliseconds
            2024-07-22 19:11:53,646 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/createRequirementStatus] finished in [191] milliseconds
            2024-07-22 19:11:53,649 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/createRequirementStatus] finished in [2] milliseconds
            2024-07-22 19:11:53,651 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/createRequirementStatus] finished in [1] milliseconds
            2024-07-22 19:11:53,652 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/createRequirementStatus] finished in [1] milliseconds
            2024-07-22 19:12:22,854 |jsse-nio-8443-exec-4 |LoginWorker                   |W| Received a null Security object from HttpServletRequest
            2024-07-22 19:12:22,854 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[FindInventoryEventPlan(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
            2024-07-22 19:12:22,869 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.001s, 149 requests, 66 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/webapp/manufacturing/WEB-INF/contro
            ller.xml
            2024-07-22 19:12:22,884 |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
            2024-07-22 19:12:22,902 |jsse-nio-8443-exec-4 |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
            2024-07-22 19:12:22,918 |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
            2024-07-22 19:12:22,919 |jsse-nio-8443-exec-4 |JWTManager                    |I| Internal single sign on is disabled.
            2024-07-22 19:12:22,923 |jsse-nio-8443-exec-4 |RequestHandler                |I| Rendering View [FindMrpPlannedEvents].  Hidden sessionId by default.
            2024-07-22 19:12:22,932 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 4 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/MrpScreens.xml
            2024-07-22 19:12:23,018 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 2 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/CommonScreens.xml
            2024-07-22 19:12:23,024 |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
            2024-07-22 19:12:23,062 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [12] milliseconds
            2024-07-22 19:12:23,075 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 27 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml
            2024-07-22 19:12:23,140 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 26 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common-theme/widget/CommonScreens.xml
            2024-07-22 19:12:23,251 |jsse-nio-8443-exec-4 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
            2024-07-22 19:12:23,255 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[FindInventoryEventPlan(Domain:https://localhost)] Request Done- total:0.401,since last([FindInventoryEve...):0.401]]
            

            And the log screen:

            Maybe the version you use is not up to date? Or do you mean that you could not reproduce on stable demo? That would be very weird. Because ,as me, the stable demo uses the HEAD version (6c3b006) as you can check at bottom of each screen there.

            HTH

            jleroux Jacques Le Roux added a comment - Using my local 18.12 HEAD version I again confirm it's working. Here are the proofs: Log 2024-07-22 19:11:28,465 |jsse-nio-8443-exec-2 |ControlServlet |T| [[[RunMrp(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]] 2024-07-22 19:11:28,480 |jsse-nio-8443-exec-2 |ConfigXMLReader |I| controller loaded: 0.002s, 149 requests, 66 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/webapp/manufacturing/WEB-INF/contro ller.xml 2024-07-22 19:11:28,502 |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 2024-07-22 19:11:28,514 |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 2024-07-22 19:11:28,525 |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 2024-07-22 19:11:28,526 |jsse-nio-8443-exec-2 |JWTManager |I| Internal single sign on is disabled. 2024-07-22 19:11:28,530 |jsse-nio-8443-exec-2 |RequestHandler |I| Rendering View [MrpExecution]. Hidden sessionId by default. 2024-07-22 19:11:28,538 |jsse-nio-8443-exec-2 |ScreenFactory |I| Got 4 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/MrpScreens.xml 2024-07-22 19:11:28,543 |jsse-nio-8443-exec-2 |ScreenFactory |I| Got 2 screens in 0.004s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/CommonScreens.xml 2024-07-22 19:11:28,549 |jsse-nio-8443-exec-2 |ScreenFactory |I| Got 1 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml 2024-07-22 19:11:28,584 |jsse-nio-8443-exec-2 |ServiceDispatcher |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [12] milliseconds 2024-07-22 19:11:28,594 |jsse-nio-8443-exec-2 |ScreenFactory |I| Got 27 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml 2024-07-22 19:11:28,651 |jsse-nio-8443-exec-2 |ScreenFactory |I| Got 26 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common-theme/widget/CommonScreens.xml 2024-07-22 19:11:28,744 |jsse-nio-8443-exec-2 |ServerHitBin |I| Visit delegatorName=default, ServerHitBin delegatorName=default 2024-07-22 19:11:28,745 |jsse-nio-8443-exec-2 |ControlServlet |T| [[[RunMrp(Domain:https://localhost)] Request Done- total:0.28,since last([RunMrp(Domain:ht...):0.28]] 2024-07-22 19:11:49,914 |jsse-nio-8443-exec-3 |LoginWorker |W| Received a null Security object from HttpServletRequest 2024-07-22 19:11:49,914 |jsse-nio-8443-exec-3 |ControlServlet |T| [[[runMrpGo(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]] 2024-07-22 19:11:49,933 |jsse-nio-8443-exec-3 |ConfigXMLReader |I| controller loaded: 0.002s, 149 requests, 66 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/webapp/manufacturing/WEB-INF/contro ller.xml 2024-07-22 19:11:49,948 |jsse-nio-8443-exec-3 |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 2024-07-22 19:11:49,959 |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 2024-07-22 19:11:49,971 |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 2024-07-22 19:11:49,972 |jsse-nio-8443-exec-3 |JWTManager |I| Internal single sign on is disabled. 2024-07-22 19:11:49,977 |jsse-nio-8443-exec-3 |ServiceDispatcher |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'manufacturing / executeMrp' 2024-07-22 19:11:50,022 |jsse-nio-8443-exec-3 |GenericAsyncEngine |I| Persisted job queued : 1721668310012 2024-07-22 19:11:50,022 |jsse-nio-8443-exec-3 |ServiceDispatcher |T| [[ASync service finished...- total:0.045,since last(ASync service sta...):0.045]] - 'manufacturing / executeMrp' 2024-07-22 19:11:50,023 |jsse-nio-8443-exec-3 |RequestHandler |I| Ran Event [service:async#executeMrp] from [request], result is [success] 2024-07-22 19:11:50,024 |jsse-nio-8443-exec-3 |RequestHandler |I| Rendering View [RunMrpGo]. Hidden sessionId by default. 2024-07-22 19:11:50,025 |jsse-nio-8443-exec-3 |ServiceDispatcher |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [1] milliseconds 2024-07-22 19:11:50,033 |jsse-nio-8443-exec-3 |ScreenFactory |I| Got 4 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/MrpScreens.xml 2024-07-22 19:11:50,067 |jsse-nio-8443-exec-3 |ScreenFactory |I| Got 2 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/CommonScreens.xml 2024-07-22 19:11:50,073 |jsse-nio-8443-exec-3 |ScreenFactory |I| Got 1 screens in 0.005s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/commonext/widget/CommonScreens.xml 2024-07-22 19:11:50,121 |jsse-nio-8443-exec-3 |ServiceDispatcher |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [15] milliseconds 2024-07-22 19:11:50,134 |jsse-nio-8443-exec-3 |ScreenFactory |I| Got 27 screens in 0.008s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml 2024-07-22 19:11:50,203 |jsse-nio-8443-exec-3 |ScreenFactory |I| Got 26 screens in 0.008s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common-theme/widget/CommonScreens.xml 2024-07-22 19:11:50,310 |jsse-nio-8443-exec-3 |ServerHitBin |I| Visit delegatorName=default, ServerHitBin delegatorName=default 2024-07-22 19:11:50,312 |jsse-nio-8443-exec-3 |ControlServlet |T| [[[runMrpGo(Domain:https://localhost)] Request Done- total:0.398,since last([runMrpGo(Domain:...):0.398]] 2024-07-22 19:11:52,481 |OFBiz-JobQueue-0 |PersistedServiceJob |I| Job [1721668310012] Id [16532] -- Next runtime: Thu Jan 01 00:59:59 CET 1970 2024-07-22 19:11:52,514 |OFBiz-JobQueue-0 |MrpServices |I| executeMrp called 2024-07-22 19:11:52,523 |OFBiz-JobQueue-0 |SequenceUtil |I| Got bank of sequenced IDs for [MrpEvent]; curSeqId=10040, maxSeqId=10050, bankSize=10 2024-07-22 19:11:53,069 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [27] milliseconds 2024-07-22 19:11:53,076 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [7] milliseconds 2024-07-22 19:11:53,079 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds 2024-07-22 19:11:53,081 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,085 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,087 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,090 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,091 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,093 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,094 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,096 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,097 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,099 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,102 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds 2024-07-22 19:11:53,103 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,144 |OFBiz-JobQueue-0 |MrpServices |I| return from initMrpEvent 2024-07-22 19:11:53,144 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/initMrpEvents] finished in [621] milliseconds 2024-07-22 19:11:53,178 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds 2024-07-22 19:11:53,265 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [24] milliseconds 2024-07-22 19:11:53,316 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [51] milliseconds 2024-07-22 19:11:53,316 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [137] milliseconds 2024-07-22 19:11:53,321 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds 2024-07-22 19:11:53,327 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,329 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [2] milliseconds 2024-07-22 19:11:53,330 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds 2024-07-22 19:11:53,333 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,338 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,340 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [2] milliseconds 2024-07-22 19:11:53,340 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds 2024-07-22 19:11:53,346 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,348 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [2] milliseconds 2024-07-22 19:11:53,348 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds 2024-07-22 19:11:53,385 |OFBiz-JobQueue-0 |SequenceUtil |I| Got bank of sequenced IDs for [Requirement]; curSeqId=10080, maxSeqId=10090, bankSize=10 2024-07-22 19:11:53,385 |OFBiz-JobQueue-0 |PrimaryKeyFinder |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()] 2024-07-22 19:11:53,454 |OFBiz-JobQueue-0 |UtilProperties |I| ResourceBundle ServiceUiLabels (en) created in 0.044s with 4 properties 2024-07-22 19:11:53,454 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String] 2024-07-22 19:11:53,454 |OFBiz-JobQueue-0 |ServiceEcaCondition |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null. 2024-07-22 19:11:53,454 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String] 2024-07-22 19:11:53,454 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,454 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,455 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service finished...- total:0.001,since last(ASync service sta...):0.001]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,455 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,506 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/autoAssignRequirementToSupplier] finished in [50] milliseconds 2024-07-22 19:11:53,506 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/createRequirement] finished in [136] milliseconds 2024-07-22 19:11:53,514 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds 2024-07-22 19:11:53,523 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [3] milliseconds 2024-07-22 19:11:53,528 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [4] milliseconds 2024-07-22 19:11:53,528 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [13] milliseconds 2024-07-22 19:11:53,532 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,534 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,534 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds 2024-07-22 19:11:53,535 |OFBiz-JobQueue-0 |PrimaryKeyFinder |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()] 2024-07-22 19:11:53,537 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String] 2024-07-22 19:11:53,537 |OFBiz-JobQueue-0 |ServiceEcaCondition |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null. 2024-07-22 19:11:53,537 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String] 2024-07-22 19:11:53,537 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,537 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,541 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service finished...- total:0.004,since last(ASync service sta...):0.004]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,541 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,542 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/autoAssignRequirementToSupplier] finished in [1] milliseconds 2024-07-22 19:11:53,542 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/createRequirement] finished in [7] milliseconds 2024-07-22 19:11:53,571 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [2] milliseconds 2024-07-22 19:11:53,577 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,579 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [2] milliseconds 2024-07-22 19:11:53,579 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [7] milliseconds 2024-07-22 19:11:53,583 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,586 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [3] milliseconds 2024-07-22 19:11:53,586 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [7] milliseconds 2024-07-22 19:11:53,588 |OFBiz-JobQueue-0 |PrimaryKeyFinder |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()] 2024-07-22 19:11:53,589 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String] 2024-07-22 19:11:53,589 |OFBiz-JobQueue-0 |ServiceEcaCondition |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null. 2024-07-22 19:11:53,589 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String] 2024-07-22 19:11:53,589 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,589 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,589 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service finished...- total:0.0,since last(ASync service sta...):0.0]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,589 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,592 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/autoAssignRequirementToSupplier] finished in [3] milliseconds 2024-07-22 19:11:53,592 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/createRequirement] finished in [5] milliseconds 2024-07-22 19:11:53,615 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getInventoryAvailableByFacility] finished in [1] milliseconds 2024-07-22 19:11:53,620 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,623 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [2] milliseconds 2024-07-22 19:11:53,623 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [7] milliseconds 2024-07-22 19:11:53,627 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [1] milliseconds 2024-07-22 19:11:53,629 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getProductRouting] finished in [2] milliseconds 2024-07-22 19:11:53,629 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/getManufacturingComponents] finished in [6] milliseconds 2024-07-22 19:11:53,630 |OFBiz-JobQueue-0 |PrimaryKeyFinder |I| Returning null because found incomplete primary key in find: [GenericEntity:Requirement][requirementId,null()] 2024-07-22 19:11:53,631 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [requirementTypeId][equals][INTERNAL_REQUIREMENT][true][String] 2024-07-22 19:11:53,631 |OFBiz-JobQueue-0 |ServiceEcaCondition |I| From Field (custRequestId) is not found in context for createRequirement, defaulting to null. 2024-07-22 19:11:53,631 |OFBiz-JobQueue-0 |ServiceEcaRule |I| For Service ECA [createRequirement] on [commit] got false for condition: [custRequestId][is-not-empty][true][String] 2024-07-22 19:11:53,631 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: createRequirementStatus, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,631 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,631 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[ASync service finished...- total:0.0,since last(ASync service sta...):0.0]] - 'default / createRequirementStatus' 2024-07-22 19:11:53,631 |OFBiz-JobQueue-0 |ServiceEcaRule |I| Running Service ECA Service: autoAssignRequirementToSupplier, triggered by rule on Service: createRequirement 2024-07-22 19:11:53,633 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/autoAssignRequirementToSupplier] finished in [2] milliseconds 2024-07-22 19:11:53,634 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/createRequirement] finished in [5] milliseconds 2024-07-22 19:11:53,638 |OFBiz-JobQueue-0 |MrpServices |I| return from executeMrp 2024-07-22 19:11:53,641 |OFBiz-JobQueue-0 |ServiceDispatcher |T| Sync service [default/executeMrp] finished in [1130] milliseconds 2024-07-22 19:11:53,646 |OFBiz-JobQueue-1 |ServiceDispatcher |T| Sync service [default/createRequirementStatus] finished in [191] milliseconds 2024-07-22 19:11:53,649 |OFBiz-JobQueue-1 |ServiceDispatcher |T| Sync service [default/createRequirementStatus] finished in [2] milliseconds 2024-07-22 19:11:53,651 |OFBiz-JobQueue-1 |ServiceDispatcher |T| Sync service [default/createRequirementStatus] finished in [1] milliseconds 2024-07-22 19:11:53,652 |OFBiz-JobQueue-1 |ServiceDispatcher |T| Sync service [default/createRequirementStatus] finished in [1] milliseconds 2024-07-22 19:12:22,854 |jsse-nio-8443-exec-4 |LoginWorker |W| Received a null Security object from HttpServletRequest 2024-07-22 19:12:22,854 |jsse-nio-8443-exec-4 |ControlServlet |T| [[[FindInventoryEventPlan(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]] 2024-07-22 19:12:22,869 |jsse-nio-8443-exec-4 |ConfigXMLReader |I| controller loaded: 0.001s, 149 requests, 66 views in file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/webapp/manufacturing/WEB-INF/contro ller.xml 2024-07-22 19:12:22,884 |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 2024-07-22 19:12:22,902 |jsse-nio-8443-exec-4 |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 2024-07-22 19:12:22,918 |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 2024-07-22 19:12:22,919 |jsse-nio-8443-exec-4 |JWTManager |I| Internal single sign on is disabled. 2024-07-22 19:12:22,923 |jsse-nio-8443-exec-4 |RequestHandler |I| Rendering View [FindMrpPlannedEvents]. Hidden sessionId by default. 2024-07-22 19:12:22,932 |jsse-nio-8443-exec-4 |ScreenFactory |I| Got 4 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/MrpScreens.xml 2024-07-22 19:12:23,018 |jsse-nio-8443-exec-4 |ScreenFactory |I| Got 2 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/applications/manufacturing/widget/manufacturing/CommonScreens.xml 2024-07-22 19:12:23,024 |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 2024-07-22 19:12:23,062 |jsse-nio-8443-exec-4 |ServiceDispatcher |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [12] milliseconds 2024-07-22 19:12:23,075 |jsse-nio-8443-exec-4 |ScreenFactory |I| Got 27 screens in 0.006s from: file:/C:/projectsASF/Git/ofbiz-framework/framework/common/widget/CommonScreens.xml 2024-07-22 19:12:23,140 |jsse-nio-8443-exec-4 |ScreenFactory |I| Got 26 screens in 0.007s from: file:/C:/projectsASF/Git/ofbiz-framework/themes/common-theme/widget/CommonScreens.xml 2024-07-22 19:12:23,251 |jsse-nio-8443-exec-4 |ServerHitBin |I| Visit delegatorName=default, ServerHitBin delegatorName=default 2024-07-22 19:12:23,255 |jsse-nio-8443-exec-4 |ControlServlet |T| [[[FindInventoryEventPlan(Domain:https://localhost)] Request Done- total:0.401,since last([FindInventoryEve...):0.401]] And the log screen: Maybe the version you use is not up to date? Or do you mean that you could not reproduce on stable demo? That would be very weird. Because ,as me, the stable demo uses the HEAD version (6c3b006) as you can check at bottom of each screen there. HTH

            Ah, we just crossed on wire. Let me check what happens in stable demo log.

            jleroux Jacques Le Roux added a comment - Ah, we just crossed on wire. Let me check what happens in stable demo log.
            jleroux Jacques Le Roux added a comment - - edited

            Here is the only line I found in today error.log that contains the mrp "word"

            2024-07-22 08:59:45,491 |OFBiz-JobQueue-0 |GenericServiceJob |E| Async-Service failed.
            org.apache.ofbiz.service.ServiceAuthException: User authorization is required for this service: executeMrp

            jleroux Jacques Le Roux added a comment - - edited Here is the only line I found in today error.log that contains the mrp "word" 2024-07-22 08:59:45,491 |OFBiz-JobQueue-0 |GenericServiceJob |E| Async-Service failed. org.apache.ofbiz.service.ServiceAuthException: User authorization is required for this service: executeMrp

            Checking the ofbiz.log (actually ofbiz.log.1) will take more time. I have the files locally, I'll check tmrw.

            jleroux Jacques Le Roux added a comment - Checking the ofbiz.log (actually ofbiz.log.1) will take more time. I have the files locally, I'll check tmrw.

            Here is the related part of log in ofbiz.log.1.

            2024-07-22 08:59:45,467 |OFBiz-JobQueue-0     |PersistedServiceJob           |I| Job  [1721638778315] Id [10047] -- Next runtime: Wed Dec 31 23:59:59 UTC 1969
            2024-07-22 08:59:45,486 |OFBiz-JobQueue-0     |UtilObject                    |E| null
            java.io.InvalidClassException: filter status: REJECTED
            	at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readHandle(ObjectInputStream.java:1801) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1844) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readArray(ObjectInputStream.java:2074) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1657) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~[?:1.8.0_412]
            	at java.util.HashMap.readObject(HashMap.java:1418) ~[?:1.8.0_412]
            	at sun.reflect.GeneratedMethodAccessor647.invoke(Unknown Source) ~[?:?]
            	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_412]
            	at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_412]
            	at java.io.ObjectStreamClass.invokeReadObject(ObjectStreamClass.java:1184) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2322) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~[?:1.8.0_412]
            	at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~[?:1.8.0_412]
            	at org.apache.ofbiz.base.util.UtilObject.getObjectException(UtilObject.java:96) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.base.util.UtilObject.getObject(UtilObject.java:79) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:475) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412]
            	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412]
            	at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412]
            2024-07-22 08:59:45,488 |OFBiz-JobQueue-0     |PersistedServiceJob           |E| PersistedServiceJob.getContext(): Serialize Exception
            org.apache.ofbiz.entity.serialize.SerializeException: Problem deserializing object from byte array + cus-obj
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:481) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412]
            	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412]
            	at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412]
            2024-07-22 08:59:45,489 |OFBiz-JobQueue-0     |PersistedServiceJob           |E| Job context is null
            2024-07-22 08:59:45,489 |OFBiz-JobQueue-0     |ServiceDispatcher             |T| [[Sync service failed...- total:0.0,since last(Begin):0.0]] - 'default / executeMrp'
            2024-07-22 08:59:45,490 |OFBiz-JobQueue-0     |TransactionUtil               |I| Transaction rolled back
            2024-07-22 08:59:45,490 |OFBiz-JobQueue-0     |TransactionUtil               |W| Not committing transaction, status is No Transaction (6)
            2024-07-22 08:59:45,491 |OFBiz-JobQueue-0     |GenericServiceJob             |E| Async-Service failed.
            org.apache.ofbiz.service.ServiceAuthException: User authorization is required for this service: executeMrp
            	at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:375) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:240) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            	at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412]
            	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412]
            	at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412]
            2024-07-22 08:59:45,491 |OFBiz-JobQueue-0     |PersistedServiceJob           |W| Persisted Job [10047] Failed. Max Retry Hit, not re-scheduling
            

            The problem is not an authorisation (I saw you use admin). But a Serialize Exception. It could be something in the data you use in your MRP.
            Are you strictly following Sharan tuto?

            jleroux Jacques Le Roux added a comment - Here is the related part of log in ofbiz.log.1. 2024-07-22 08:59:45,467 |OFBiz-JobQueue-0 |PersistedServiceJob |I| Job [1721638778315] Id [10047] -- Next runtime: Wed Dec 31 23:59:59 UTC 1969 2024-07-22 08:59:45,486 |OFBiz-JobQueue-0 |UtilObject |E| null java.io.InvalidClassException: filter status: REJECTED at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~[?:1.8.0_412] at java.io.ObjectInputStream.readHandle(ObjectInputStream.java:1801) ~[?:1.8.0_412] at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1844) ~[?:1.8.0_412] at java.io.ObjectInputStream.readArray(ObjectInputStream.java:2074) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1657) ~[?:1.8.0_412] at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412] at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~[?:1.8.0_412] at java.util.HashMap.readObject(HashMap.java:1418) ~[?:1.8.0_412] at sun.reflect.GeneratedMethodAccessor647.invoke(Unknown Source) ~[?:?] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_412] at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_412] at java.io.ObjectStreamClass.invokeReadObject(ObjectStreamClass.java:1184) ~[?:1.8.0_412] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2322) ~[?:1.8.0_412] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412] at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412] at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412] at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412] at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412] at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~[?:1.8.0_412] at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~[?:1.8.0_412] at org.apache.ofbiz.base.util.UtilObject.getObjectException(UtilObject.java:96) ~[ofbiz.jar:?] at org.apache.ofbiz.base.util.UtilObject.getObject(UtilObject.java:79) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:475) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412] at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412] 2024-07-22 08:59:45,488 |OFBiz-JobQueue-0 |PersistedServiceJob |E| PersistedServiceJob.getContext(): Serialize Exception org.apache.ofbiz.entity.serialize.SerializeException: Problem deserializing object from byte array + cus-obj at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:481) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?] at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412] at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412] 2024-07-22 08:59:45,489 |OFBiz-JobQueue-0 |PersistedServiceJob |E| Job context is null 2024-07-22 08:59:45,489 |OFBiz-JobQueue-0 |ServiceDispatcher |T| [[Sync service failed...- total:0.0,since last(Begin):0.0]] - 'default / executeMrp' 2024-07-22 08:59:45,490 |OFBiz-JobQueue-0 |TransactionUtil |I| Transaction rolled back 2024-07-22 08:59:45,490 |OFBiz-JobQueue-0 |TransactionUtil |W| Not committing transaction, status is No Transaction (6) 2024-07-22 08:59:45,491 |OFBiz-JobQueue-0 |GenericServiceJob |E| Async-Service failed. org.apache.ofbiz.service.ServiceAuthException: User authorization is required for this service: executeMrp at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:375) ~[ofbiz.jar:?] at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:240) ~[ofbiz.jar:?] at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?] at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412] at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412] 2024-07-22 08:59:45,491 |OFBiz-JobQueue-0 |PersistedServiceJob |W| Persisted Job [10047] Failed. Max Retry Hit, not re-scheduling The problem is not an authorisation (I saw you use admin). But a Serialize Exception. It could be something in the data you use in your MRP. Are you strictly following Sharan tuto?
            emad1967 Emad Radwan added a comment -

            Please check what I mentioned in the top of this thread. Here it's again:

            Hello Community, I'm working with the Manufacturing tutorial on Sharan's
            book - making tables with wood, nails and varnish - when I run the MRP and
            as guided I got the authentication error that - when searched - found that
            this was reported before in the following thread but unfortunately when I
            applied the workaround - noticed that the problem still there in the online
            demo - it didn't work for me and I got the following error message which is
            not describing exactly what is happening as I entered the 'facilityId' in
            the params. facilityId and facilityGroupId cannot be both null
            https://lists.apache.org/list?user@ofbiz.apache.org:2022-11:User%20authorization%20is%20required%20for%20this%20service:%20executeMrp
            Regards,
            Emad

            On Tue, Jul 23, 2024 at 10:50 AM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - Please check what I mentioned in the top of this thread. Here it's again: Hello Community, I'm working with the Manufacturing tutorial on Sharan's book - making tables with wood, nails and varnish - when I run the MRP and as guided I got the authentication error that - when searched - found that this was reported before in the following thread but unfortunately when I applied the workaround - noticed that the problem still there in the online demo - it didn't work for me and I got the following error message which is not describing exactly what is happening as I entered the 'facilityId' in the params. facilityId and facilityGroupId cannot be both null https://lists.apache.org/list?user@ofbiz.apache.org:2022-11:User%20authorization%20is%20required%20for%20this%20service:%20executeMrp Regards, Emad On Tue, Jul 23, 2024 at 10:50 AM Jacques Le Roux (Jira) <jira@apache.org>

            As I said the deep problem is not authorisation but a Serialize Exception. It's obvious in the log I put above the so called authorisation issue happens at "2024-07-22 08:59:45,491" when the real reason (ie the Serialize Exception) happens at "2024-07-22 08:59:45,486 "

            So I don't know what's in your data (or way to create them maybe) but something generates a java.io.InvalidClassException which is at the top of the stack.

            Another explanation is that it'd work locally but not with the stable demo. That seems unlikely to me.

            While at it, here is an image of what I use to create the job that works locally:

            jleroux Jacques Le Roux added a comment - As I said the deep problem is not authorisation but a Serialize Exception. It's obvious in the log I put above the so called authorisation issue happens at "2024-07-22 08:59:45,491" when the real reason (ie the Serialize Exception) happens at "2024-07-22 08:59:45,486 " So I don't know what's in your data (or way to create them maybe) but something generates a java.io.InvalidClassException which is at the top of the stack. Another explanation is that it'd work locally but not with the stable demo. That seems unlikely to me. While at it, here is an image of what I use to create the job that works locally:
            emad1967 Emad Radwan added a comment -

            here's my logs: 2024-07-23 20:39:27 2024-07-23 17:39:27,921 |sse-nio-8443-exec-10 |LoginWorker                   |W| Received a null Security object from HttpServletRequest
            2024-07-23 20:39:27 2024-07-23 17:39:27,921 |sse-nio-8443-exec-10 |ControlServlet                |T| [[[runMrpGo(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
            2024-07-23 20:39:27 2024-07-23 17:39:27,949 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.002s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml
            2024-07-23 20:39:27 2024-07-23 17:39:27,962 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml
            2024-07-23 20:39:27 2024-07-23 17:39:27,974 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml
            2024-07-23 20:39:27 2024-07-23 17:39:27,990 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml
            2024-07-23 20:39:27 2024-07-23 17:39:27,991 |sse-nio-8443-exec-10 |JWTManager                    |I| Internal single sign on is disabled.
            2024-07-23 20:39:28 2024-07-23 17:39:28,012 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'manufacturing / executeMrp'
            2024-07-23 20:39:28 2024-07-23 17:39:28,042 |sse-nio-8443-exec-10 |SequenceUtil                  |I| Got bank of sequenced IDs for [RuntimeData]; curSeqId=10100, maxSeqId=10200, bankSize=100
            2024-07-23 20:39:28 2024-07-23 17:39:28,652 |sse-nio-8443-exec-10 |GenericAsyncEngine            |I| Persisted job queued : 1721756368639
            2024-07-23 20:39:28 2024-07-23 17:39:28,652 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| [[ASync service finished...- total:0.64,since last(ASync service sta...):0.64]] - 'manufacturing / executeMrp'
            2024-07-23 20:39:28 2024-07-23 17:39:28,657 |sse-nio-8443-exec-10 |RequestHandler                |I| Ran Event service:async#executeMrp from [request], result is [success]
            2024-07-23 20:39:28 2024-07-23 17:39:28,657 |sse-nio-8443-exec-10 |RequestHandler                |I| Rendering View [RunMrpGo].  Hidden sessionId by default.
            2024-07-23 20:39:28 2024-07-23 17:39:28,659 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [1] milliseconds
            2024-07-23 20:39:28 2024-07-23 17:39:28,676 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 4 screens in 0.012s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml
            2024-07-23 20:39:28 2024-07-23 17:39:28,780 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 2 screens in 0.007s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml
            2024-07-23 20:39:28 2024-07-23 17:39:28,787 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 1 screens in 0.006s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml
            2024-07-23 20:39:28 2024-07-23 17:39:28,834 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [13] milliseconds
            2024-07-23 20:39:28 2024-07-23 17:39:28,845 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 27 screens in 0.006s from: file:/ofbiz/framework/common/widget/CommonScreens.xml
            2024-07-23 20:39:28 2024-07-23 17:39:28,919 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 26 screens in 0.008s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml
            2024-07-23 20:39:29 2024-07-23 17:39:29,053 |sse-nio-8443-exec-10 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
            2024-07-23 20:39:29 2024-07-23 17:39:29,056 |sse-nio-8443-exec-10 |ControlServlet                |T| [[[runMrpGo(Domain:https://localhost)] Request Done- total:1.135,since last([runMrpGo(Domain:...):1.135]]
            2024-07-23 20:39:43 2024-07-23 17:39:43,413 |jsse-nio-8443-exec-4 |LoginWorker                   |W| Received a null Security object from HttpServletRequest
            2024-07-23 20:39:43 2024-07-23 17:39:43,413 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[FindInventoryEventPlan(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
            2024-07-23 20:39:43 2024-07-23 17:39:43,533 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.004s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,589 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.003s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,615 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.002s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,649 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,649 |jsse-nio-8443-exec-4 |JWTManager                    |I| Internal single sign on is disabled.
            2024-07-23 20:39:43 2024-07-23 17:39:43,655 |jsse-nio-8443-exec-4 |RequestHandler                |I| Rendering View [FindMrpPlannedEvents].  Hidden sessionId by default.
            2024-07-23 20:39:43 2024-07-23 17:39:43,658 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [2] milliseconds
            2024-07-23 20:39:43 2024-07-23 17:39:43,677 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 4 screens in 0.015s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,821 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 2 screens in 0.005s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,828 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 1 screens in 0.006s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,882 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [11] milliseconds
            2024-07-23 20:39:43 2024-07-23 17:39:43,893 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 27 screens in 0.005s from: file:/ofbiz/framework/common/widget/CommonScreens.xml
            2024-07-23 20:39:43 2024-07-23 17:39:43,970 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 26 screens in 0.008s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml
            2024-07-23 20:39:44 2024-07-23 17:39:44,377 |jsse-nio-8443-exec-4 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
            2024-07-23 20:39:44 2024-07-23 17:39:44,385 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[FindInventoryEventPlan(Domain:https://localhost)] Request Done- total:0.972,since last([FindInventoryEve...):0.972]]
            2024-07-23 20:39:51 2024-07-23 17:39:51,697 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [1721756368639] Id [12721] – Next runtime: Wed Dec 31 23:59:59 UTC 1969
            2024-07-23 20:39:51 Jul 23, 2024 5:39:51 PM java.io.ObjectInputStream filterCheck
            2024-07-23 20:39:51 INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 7, bytes: 12655, ex: n/a
            2024-07-23 20:39:51 2024-07-23 17:39:51,747 |OFBiz-JobQueue-1     |UtilObject                    |E| null
            2024-07-23 20:39:51 java.io.InvalidClassException: filter status: REJECTED
            2024-07-23 20:39:51 at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readHandle(ObjectInputStream.java:1801) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1844) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readArray(ObjectInputStream.java:2074) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1657) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.util.HashMap.readObject(HashMap.java:1418) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.lang.reflect.Method.invoke(Method.java:498) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectStreamClass.invokeReadObject(ObjectStreamClass.java:1184) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2322) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at org.apache.ofbiz.base.util.UtilObject.getObjectException(UtilObject.java:96) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.base.util.UtilObject.getObject(UtilObject.java:79) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:475) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412]
            2024-07-23 20:39:51 2024-07-23 17:39:51,782 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| PersistedServiceJob.getContext(): Serialize Exception
            2024-07-23 20:39:51 org.apache.ofbiz.entity.serialize.SerializeException: Problem deserializing object from byte array + cus-obj
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:481) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412]
            2024-07-23 20:39:51 2024-07-23 17:39:51,782 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| Job context is null
            2024-07-23 20:39:51 2024-07-23 17:39:51,796 |OFBiz-JobQueue-1     |MrpServices                   |I| executeMrp called
            2024-07-23 20:39:51 2024-07-23 17:39:51,796 |OFBiz-JobQueue-1     |ServiceUtil                   |E| {errorMessage=facilityId and facilityGroupId cannot be both null, responseMessage=error}
            2024-07-23 20:39:51 2024-07-23 17:39:51,797 |OFBiz-JobQueue-1     |ServiceDispatcher             |E| Error in Service [executeMrp]: facilityId and facilityGroupId cannot be both null
            2024-07-23 20:39:51 2024-07-23 17:39:51,797 |OFBiz-JobQueue-1     |TransactionUtil               |E| [TransactionUtil.rollback]
            2024-07-23 20:39:51 java.lang.Exception: Stack Trace
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:314) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:290) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:559) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:240) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412]
            2024-07-23 20:39:51 2024-07-23 17:39:51,798 |OFBiz-JobQueue-1     |TransactionUtil               |I| Transaction rolled back
            2024-07-23 20:39:51 2024-07-23 17:39:51,798 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/executeMrp] finished in [13] milliseconds
            2024-07-23 20:39:51 2024-07-23 17:39:51,801 |OFBiz-JobQueue-1     |GenericServiceJob             |E| Async-Service failed.
            2024-07-23 20:39:51 java.lang.Exception: facilityId and facilityGroupId cannot be both null
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:73) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_412]
            2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~[?:1.8.0_412]
            2024-07-23 20:39:51 2024-07-23 17:39:51,802 |OFBiz-JobQueue-1     |PersistedServiceJob           |W| Persisted Job [12721] Failed. Max Retry Hit, not re-scheduling

            emad1967 Emad Radwan added a comment - here's my logs: 2024-07-23 20:39:27 2024-07-23 17:39:27,921 |sse-nio-8443-exec-10 |LoginWorker                   |W| Received a null Security object from HttpServletRequest 2024-07-23 20:39:27 2024-07-23 17:39:27,921 |sse-nio-8443-exec-10 |ControlServlet                |T| [[ [runMrpGo(Domain:https://localhost)] Request Begun, encoding= [UTF-8] - total:0.0,since last(Begin):0.0]] 2024-07-23 20:39:27 2024-07-23 17:39:27,949 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.002s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml 2024-07-23 20:39:27 2024-07-23 17:39:27,962 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml 2024-07-23 20:39:27 2024-07-23 17:39:27,974 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml 2024-07-23 20:39:27 2024-07-23 17:39:27,990 |sse-nio-8443-exec-10 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml 2024-07-23 20:39:27 2024-07-23 17:39:27,991 |sse-nio-8443-exec-10 |JWTManager                    |I| Internal single sign on is disabled. 2024-07-23 20:39:28 2024-07-23 17:39:28,012 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| [ [ASync service started...- total:0.0,since last(Begin):0.0] ] - 'manufacturing / executeMrp' 2024-07-23 20:39:28 2024-07-23 17:39:28,042 |sse-nio-8443-exec-10 |SequenceUtil                  |I| Got bank of sequenced IDs for [RuntimeData] ; curSeqId=10100, maxSeqId=10200, bankSize=100 2024-07-23 20:39:28 2024-07-23 17:39:28,652 |sse-nio-8443-exec-10 |GenericAsyncEngine            |I| Persisted job queued : 1721756368639 2024-07-23 20:39:28 2024-07-23 17:39:28,652 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| [ [ASync service finished...- total:0.64,since last(ASync service sta...):0.64] ] - 'manufacturing / executeMrp' 2024-07-23 20:39:28 2024-07-23 17:39:28,657 |sse-nio-8443-exec-10 |RequestHandler                |I| Ran Event service:async#executeMrp from [request] , result is [success] 2024-07-23 20:39:28 2024-07-23 17:39:28,657 |sse-nio-8443-exec-10 |RequestHandler                |I| Rendering View [RunMrpGo] .  Hidden sessionId by default. 2024-07-23 20:39:28 2024-07-23 17:39:28,659 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [1] milliseconds 2024-07-23 20:39:28 2024-07-23 17:39:28,676 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 4 screens in 0.012s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml 2024-07-23 20:39:28 2024-07-23 17:39:28,780 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 2 screens in 0.007s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml 2024-07-23 20:39:28 2024-07-23 17:39:28,787 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 1 screens in 0.006s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml 2024-07-23 20:39:28 2024-07-23 17:39:28,834 |sse-nio-8443-exec-10 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [13] milliseconds 2024-07-23 20:39:28 2024-07-23 17:39:28,845 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 27 screens in 0.006s from: file:/ofbiz/framework/common/widget/CommonScreens.xml 2024-07-23 20:39:28 2024-07-23 17:39:28,919 |sse-nio-8443-exec-10 |ScreenFactory                 |I| Got 26 screens in 0.008s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml 2024-07-23 20:39:29 2024-07-23 17:39:29,053 |sse-nio-8443-exec-10 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default 2024-07-23 20:39:29 2024-07-23 17:39:29,056 |sse-nio-8443-exec-10 |ControlServlet                |T| [[ [runMrpGo(Domain:https://localhost)] Request Done- total:1.135,since last( [runMrpGo(Domain:...):1.135] ] 2024-07-23 20:39:43 2024-07-23 17:39:43,413 |jsse-nio-8443-exec-4 |LoginWorker                   |W| Received a null Security object from HttpServletRequest 2024-07-23 20:39:43 2024-07-23 17:39:43,413 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[ [FindInventoryEventPlan(Domain:https://localhost)] Request Begun, encoding= [UTF-8] - total:0.0,since last(Begin):0.0]] 2024-07-23 20:39:43 2024-07-23 17:39:43,533 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.004s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,589 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.003s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,615 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.002s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,649 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,649 |jsse-nio-8443-exec-4 |JWTManager                    |I| Internal single sign on is disabled. 2024-07-23 20:39:43 2024-07-23 17:39:43,655 |jsse-nio-8443-exec-4 |RequestHandler                |I| Rendering View [FindMrpPlannedEvents] .  Hidden sessionId by default. 2024-07-23 20:39:43 2024-07-23 17:39:43,658 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [2] milliseconds 2024-07-23 20:39:43 2024-07-23 17:39:43,677 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 4 screens in 0.015s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,821 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 2 screens in 0.005s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,828 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 1 screens in 0.006s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,882 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [11] milliseconds 2024-07-23 20:39:43 2024-07-23 17:39:43,893 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 27 screens in 0.005s from: file:/ofbiz/framework/common/widget/CommonScreens.xml 2024-07-23 20:39:43 2024-07-23 17:39:43,970 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 26 screens in 0.008s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml 2024-07-23 20:39:44 2024-07-23 17:39:44,377 |jsse-nio-8443-exec-4 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default 2024-07-23 20:39:44 2024-07-23 17:39:44,385 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[ [FindInventoryEventPlan(Domain:https://localhost)] Request Done- total:0.972,since last( [FindInventoryEve...):0.972] ] 2024-07-23 20:39:51 2024-07-23 17:39:51,697 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job   [1721756368639] Id [12721] – Next runtime: Wed Dec 31 23:59:59 UTC 1969 2024-07-23 20:39:51 Jul 23, 2024 5:39:51 PM java.io.ObjectInputStream filterCheck 2024-07-23 20:39:51 INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 7, bytes: 12655, ex: n/a 2024-07-23 20:39:51 2024-07-23 17:39:51,747 |OFBiz-JobQueue-1     |UtilObject                    |E| null 2024-07-23 20:39:51 java.io.InvalidClassException: filter status: REJECTED 2024-07-23 20:39:51 at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readHandle(ObjectInputStream.java:1801) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1844) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readArray(ObjectInputStream.java:2074) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1657) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.util.HashMap.readObject(HashMap.java:1418) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.lang.reflect.Method.invoke(Method.java:498) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectStreamClass.invokeReadObject(ObjectStreamClass.java:1184) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2322) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2431) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2355) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2213) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1669) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:503) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:461) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at org.apache.ofbiz.base.util.UtilObject.getObjectException(UtilObject.java:96) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.base.util.UtilObject.getObject(UtilObject.java:79) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:475) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~ [?:1.8.0_412] 2024-07-23 20:39:51 2024-07-23 17:39:51,782 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| PersistedServiceJob.getContext(): Serialize Exception 2024-07-23 20:39:51 org.apache.ofbiz.entity.serialize.SerializeException: Problem deserializing object from byte array + cus-obj 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:481) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~ [?:1.8.0_412] 2024-07-23 20:39:51 2024-07-23 17:39:51,782 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| Job context is null 2024-07-23 20:39:51 2024-07-23 17:39:51,796 |OFBiz-JobQueue-1     |MrpServices                   |I| executeMrp called 2024-07-23 20:39:51 2024-07-23 17:39:51,796 |OFBiz-JobQueue-1     |ServiceUtil                   |E| {errorMessage=facilityId and facilityGroupId cannot be both null, responseMessage=error} 2024-07-23 20:39:51 2024-07-23 17:39:51,797 |OFBiz-JobQueue-1     |ServiceDispatcher             |E| Error in Service [executeMrp] : facilityId and facilityGroupId cannot be both null 2024-07-23 20:39:51 2024-07-23 17:39:51,797 |OFBiz-JobQueue-1     |TransactionUtil               |E| [TransactionUtil.rollback] 2024-07-23 20:39:51 java.lang.Exception: Stack Trace 2024-07-23 20:39:51 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:314) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:290) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:559) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:240) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~ [?:1.8.0_412] 2024-07-23 20:39:51 2024-07-23 17:39:51,798 |OFBiz-JobQueue-1     |TransactionUtil               |I| Transaction rolled back 2024-07-23 20:39:51 2024-07-23 17:39:51,798 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/executeMrp] finished in [13] milliseconds 2024-07-23 20:39:51 2024-07-23 17:39:51,801 |OFBiz-JobQueue-1     |GenericServiceJob             |E| Async-Service failed. 2024-07-23 20:39:51 java.lang.Exception: facilityId and facilityGroupId cannot be both null 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:73) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~ [?:1.8.0_412] 2024-07-23 20:39:51 at java.lang.Thread.run(Thread.java:750) ~ [?:1.8.0_412] 2024-07-23 20:39:51 2024-07-23 17:39:51,802 |OFBiz-JobQueue-1     |PersistedServiceJob           |W| Persisted Job [12721] Failed. Max Retry Hit, not re-scheduling
            emad1967 Emad Radwan added a comment -

             

            see here from the browser dev tools, facilityId is being sent:

            emad1967 Emad Radwan added a comment -   see here from the browser dev tools, facilityId is being sent:

            At 1st glance the stable demo log and your local are similar (see below). But there is something which makes the difference. This info:

            2024-07-23 20:39:51 INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 7, bytes: 12655, ex: n/a

            I initially thought it could be the Java version. But both are using 1.8.0_412. Also the OS is (maybe) not concerned.
            Yannong who generated a very similar issue:

            Nov 21, 2022 5:40:51 PM java.io.ObjectInputStream filterCheck INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 6, bytes: 13065, ex: n/a

            uses

            OfBiz 18.12 in my local environment (MacOS M1, jdk1.8.0_351.jdk)

            so you are, right?

            I have used Win7 with "Temurin-11.0.17+8 (build 11.0.17+8, mixed mode". Please try with JDK 11 before we get further if ncessary.

            stable demo log

            2024-07-22 08:59:45,467 |OFBiz-JobQueue-0 |PersistedServiceJob |I| Job [1721638778315] Id [10047] – Next runtime: Wed Dec 31 23:59:59 UTC 1969
            2024-07-22 08:59:45,486 |OFBiz-JobQueue-0 |UtilObject |E| null
            java.io.InvalidClassException: filter status: REJECTED
            at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~[?:1.8.0_412]

            your local

            2024-07-23 20:39:51 2024-07-23 17:39:51,697 |OFBiz-JobQueue-1 |PersistedServiceJob |I| Job [1721756368639] Id [12721] – Next runtime: Wed Dec 31 23:59:59 UTC 1969
            2024-07-23 20:39:51 Jul 23, 2024 5:39:51 PM java.io.ObjectInputStream filterCheck
            2024-07-23 20:39:51 INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 7, bytes: 12655, ex: n/a
            2024-07-23 20:39:51 2024-07-23 17:39:51,747 |OFBiz-JobQueue-1 |UtilObject |E| null
            2024-07-23 20:39:51 java.io.InvalidClassException: filter status: REJECTED
            2024-07-23 20:39:51 at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~[?:1.8.0_412]

            jleroux Jacques Le Roux added a comment - At 1st glance the stable demo log and your local are similar (see below). But there is something which makes the difference. This info: 2024-07-23 20:39:51 INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 7, bytes: 12655, ex: n/a I initially thought it could be the Java version. But both are using 1.8.0_412. Also the OS is (maybe) not concerned. Yannong who generated a very similar issue: Nov 21, 2022 5:40:51 PM java.io.ObjectInputStream filterCheck INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 6, bytes: 13065, ex: n/a uses OfBiz 18.12 in my local environment (MacOS M1, jdk1.8.0_351.jdk) so you are, right? I have used Win7 with "Temurin-11.0.17+8 (build 11.0.17+8, mixed mode". Please try with JDK 11 before we get further if ncessary. stable demo log 2024-07-22 08:59:45,467 |OFBiz-JobQueue-0 |PersistedServiceJob |I| Job [1721638778315] Id [10047] – Next runtime: Wed Dec 31 23:59:59 UTC 1969 2024-07-22 08:59:45,486 |OFBiz-JobQueue-0 |UtilObject |E| null java.io.InvalidClassException: filter status: REJECTED at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~ [?:1.8.0_412] your local 2024-07-23 20:39:51 2024-07-23 17:39:51,697 |OFBiz-JobQueue-1 |PersistedServiceJob |I| Job [1721756368639] Id [12721] – Next runtime: Wed Dec 31 23:59:59 UTC 1969 2024-07-23 20:39:51 Jul 23, 2024 5:39:51 PM java.io.ObjectInputStream filterCheck 2024-07-23 20:39:51 INFO: ObjectInputFilter REJECTED: null, array length: -1, nRefs: 501, depth: 7, bytes: 12655, ex: n/a 2024-07-23 20:39:51 2024-07-23 17:39:51,747 |OFBiz-JobQueue-1 |UtilObject |E| null 2024-07-23 20:39:51 java.io.InvalidClassException: filter status: REJECTED 2024-07-23 20:39:51 at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1333) ~ [?:1.8.0_412]
            emad1967 Emad Radwan added a comment -

            YES, I Use a MacBook Pro. I tried with JDK11 but problem still exists.

             

            2024-07-24 14:57:47 2024-07-24 11:57:47,194 |jsse-nio-8443-exec-7 |LoginWorker                   |W| Received a null Security object from HttpServletRequest
            2024-07-24 14:57:47 2024-07-24 11:57:47,194 |jsse-nio-8443-exec-7 |ControlServlet                |T| [[[RunMrp(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
            2024-07-24 14:57:47 2024-07-24 11:57:47,231 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.003s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,248 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,264 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,279 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.001s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,280 |jsse-nio-8443-exec-7 |JWTManager                    |I| Internal single sign on is disabled.
            2024-07-24 14:57:47 2024-07-24 11:57:47,284 |jsse-nio-8443-exec-7 |RequestHandler                |I| Rendering View [MrpExecution].  Hidden sessionId by default.
            2024-07-24 14:57:47 2024-07-24 11:57:47,287 |jsse-nio-8443-exec-7 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [2] milliseconds
            2024-07-24 14:57:47 2024-07-24 11:57:47,309 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 4 screens in 0.014s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,324 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 2 screens in 0.014s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,339 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 1 screens in 0.012s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,417 |jsse-nio-8443-exec-7 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [15] milliseconds
            2024-07-24 14:57:47 2024-07-24 11:57:47,448 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 27 screens in 0.014s from: file:/ofbiz/framework/common/widget/CommonScreens.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,547 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 26 screens in 0.015s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml
            2024-07-24 14:57:47 2024-07-24 11:57:47,754 |jsse-nio-8443-exec-7 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
            2024-07-24 14:57:47 2024-07-24 11:57:47,766 |jsse-nio-8443-exec-7 |ControlServlet                |T| [[[RunMrp(Domain:https://localhost)] Request Done- total:0.571,since last([RunMrp(Domain:ht...):0.571]]
            2024-07-24 14:57:57 2024-07-24 11:57:57,771 |jsse-nio-8443-exec-4 |LoginWorker                   |W| Received a null Security object from HttpServletRequest
            2024-07-24 14:57:57 2024-07-24 11:57:57,772 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[runMrpGo(Domain:https://localhost)] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]
            2024-07-24 14:57:57 2024-07-24 11:57:57,816 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.006s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml
            2024-07-24 14:57:57 2024-07-24 11:57:57,834 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml
            2024-07-24 14:57:57 2024-07-24 11:57:57,845 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml
            2024-07-24 14:57:57 2024-07-24 11:57:57,855 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml
            2024-07-24 14:57:57 2024-07-24 11:57:57,857 |jsse-nio-8443-exec-4 |JWTManager                    |I| Internal single sign on is disabled.
            2024-07-24 14:57:57 2024-07-24 11:57:57,864 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| [[ASync service started...- total:0.0,since last(Begin):0.0]] - 'manufacturing / executeMrp'
            2024-07-24 14:57:57 2024-07-24 11:57:57,912 |jsse-nio-8443-exec-4 |GenericAsyncEngine            |I| Persisted job queued : 1721822277909
            2024-07-24 14:57:57 2024-07-24 11:57:57,912 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| [[ASync service finished...- total:0.048,since last(ASync service sta...):0.048]] - 'manufacturing / executeMrp'
            2024-07-24 14:57:57 2024-07-24 11:57:57,915 |jsse-nio-8443-exec-4 |RequestHandler                |I| Ran Event service:async#executeMrp from [request], result is [success]
            2024-07-24 14:57:57 2024-07-24 11:57:57,916 |jsse-nio-8443-exec-4 |RequestHandler                |I| Rendering View [RunMrpGo].  Hidden sessionId by default.
            2024-07-24 14:57:57 2024-07-24 11:57:57,918 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [1] milliseconds
            2024-07-24 14:57:57 2024-07-24 11:57:57,940 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 4 screens in 0.016s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml
            2024-07-24 14:57:57 2024-07-24 11:57:57,955 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 2 screens in 0.012s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml
            2024-07-24 14:57:57 2024-07-24 11:57:57,976 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 1 screens in 0.017s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml
            2024-07-24 14:57:58 2024-07-24 11:57:58,074 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [15] milliseconds
            2024-07-24 14:57:58 2024-07-24 11:57:58,092 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 27 screens in 0.009s from: file:/ofbiz/framework/common/widget/CommonScreens.xml
            2024-07-24 14:57:58 2024-07-24 11:57:58,166 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 26 screens in 0.019s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml
            2024-07-24 14:57:58 2024-07-24 11:57:58,380 |jsse-nio-8443-exec-4 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default
            2024-07-24 14:57:58 2024-07-24 11:57:58,386 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[[runMrpGo(Domain:https://localhost)] Request Done- total:0.614,since last([runMrpGo(Domain:...):0.614]]
            2024-07-24 14:58:13 2024-07-24 11:58:13,208 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job  [1721822277909] Id [10017] – Next runtime: Wed Dec 31 23:59:59 UTC 1969
            2024-07-24 14:58:13 2024-07-24 11:58:13,237 |OFBiz-JobQueue-1     |UtilObject                    |E| null
            2024-07-24 14:58:13 java.io.InvalidClassException: filter status: REJECTED
            2024-07-24 14:58:13 at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1369) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readHandle(ObjectInputStream.java:1819) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1862) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readArray(ObjectInputStream.java:2089) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1675) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:489) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:447) ~[?:?]
            2024-07-24 14:58:13 at java.util.HashMap.readObject(HashMap.java:1466) ~[?:?]
            2024-07-24 14:58:13 at jdk.internal.reflect.GeneratedMethodAccessor322.invoke(Unknown Source) ~[?:?]
            2024-07-24 14:58:13 at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:?]
            2024-07-24 14:58:13 at java.lang.reflect.Method.invoke(Method.java:566) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectStreamClass.invokeReadObject(ObjectStreamClass.java:1046) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2357) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:489) ~[?:?]
            2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:447) ~[?:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.base.util.UtilObject.getObjectException(UtilObject.java:96) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.base.util.UtilObject.getObject(UtilObject.java:79) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:475) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
            2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~[?:?]
            2024-07-24 14:58:13 2024-07-24 11:58:13,238 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| PersistedServiceJob.getContext(): Serialize Exception
            2024-07-24 14:58:13 org.apache.ofbiz.entity.serialize.SerializeException: Problem deserializing object from byte array + cus-obj
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:481) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
            2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~[?:?]
            2024-07-24 14:58:13 2024-07-24 11:58:13,240 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| Job context is null
            2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |MrpServices                   |I| executeMrp called
            2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |ServiceUtil                   |E| {errorMessage=facilityId and facilityGroupId cannot be both null, responseMessage=error}
            2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |ServiceDispatcher             |E| Error in Service [executeMrp]: facilityId and facilityGroupId cannot be both null
            2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |TransactionUtil               |E| [TransactionUtil.rollback]
            2024-07-24 14:58:13 java.lang.Exception: Stack Trace
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:314) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:290) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:559) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:240) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
            2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~[?:?]
            2024-07-24 14:58:13 2024-07-24 11:58:13,243 |OFBiz-JobQueue-1     |TransactionUtil               |I| Transaction rolled back
            2024-07-24 14:58:13 2024-07-24 11:58:13,245 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/executeMrp] finished in [3] milliseconds
            2024-07-24 14:58:13 2024-07-24 11:58:13,245 |OFBiz-JobQueue-1     |GenericServiceJob             |E| Async-Service failed.
            2024-07-24 14:58:13 java.lang.Exception: facilityId and facilityGroupId cannot be both null
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:73) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~[ofbiz.jar:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
            2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
            2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~[?:?]
            2024-07-24 14:58:13 2024-07-24 11:58:13,245 |OFBiz-JobQueue-1     |PersistedServiceJob           |W| Persisted Job [10017] Failed. Max Retry Hit, not re-scheduling

            emad1967 Emad Radwan added a comment - YES, I Use a MacBook Pro. I tried with JDK11 but problem still exists.   2024-07-24 14:57:47 2024-07-24 11:57:47,194 |jsse-nio-8443-exec-7 |LoginWorker                   |W| Received a null Security object from HttpServletRequest 2024-07-24 14:57:47 2024-07-24 11:57:47,194 |jsse-nio-8443-exec-7 |ControlServlet                |T| [[ [RunMrp(Domain:https://localhost)] Request Begun, encoding= [UTF-8] - total:0.0,since last(Begin):0.0]] 2024-07-24 14:57:47 2024-07-24 11:57:47,231 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.003s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,248 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,264 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,279 |jsse-nio-8443-exec-7 |ConfigXMLReader               |I| controller loaded: 0.001s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,280 |jsse-nio-8443-exec-7 |JWTManager                    |I| Internal single sign on is disabled. 2024-07-24 14:57:47 2024-07-24 11:57:47,284 |jsse-nio-8443-exec-7 |RequestHandler                |I| Rendering View [MrpExecution] .  Hidden sessionId by default. 2024-07-24 14:57:47 2024-07-24 11:57:47,287 |jsse-nio-8443-exec-7 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [2] milliseconds 2024-07-24 14:57:47 2024-07-24 11:57:47,309 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 4 screens in 0.014s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,324 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 2 screens in 0.014s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,339 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 1 screens in 0.012s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,417 |jsse-nio-8443-exec-7 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [15] milliseconds 2024-07-24 14:57:47 2024-07-24 11:57:47,448 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 27 screens in 0.014s from: file:/ofbiz/framework/common/widget/CommonScreens.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,547 |jsse-nio-8443-exec-7 |ScreenFactory                 |I| Got 26 screens in 0.015s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml 2024-07-24 14:57:47 2024-07-24 11:57:47,754 |jsse-nio-8443-exec-7 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default 2024-07-24 14:57:47 2024-07-24 11:57:47,766 |jsse-nio-8443-exec-7 |ControlServlet                |T| [[ [RunMrp(Domain:https://localhost)] Request Done- total:0.571,since last( [RunMrp(Domain:ht...):0.571] ] 2024-07-24 14:57:57 2024-07-24 11:57:57,771 |jsse-nio-8443-exec-4 |LoginWorker                   |W| Received a null Security object from HttpServletRequest 2024-07-24 14:57:57 2024-07-24 11:57:57,772 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[ [runMrpGo(Domain:https://localhost)] Request Begun, encoding= [UTF-8] - total:0.0,since last(Begin):0.0]] 2024-07-24 14:57:57 2024-07-24 11:57:57,816 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.006s, 149 requests, 66 views in file:/ofbiz/applications/manufacturing/webapp/manufacturing/WEB-INF/controller.xml 2024-07-24 14:57:57 2024-07-24 11:57:57,834 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.001s, 48 requests, 22 views in file:/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml 2024-07-24 14:57:57 2024-07-24 11:57:57,845 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 0 requests, 0 views in file:/ofbiz/framework/common/webcommon/WEB-INF/handlers-controller.xml 2024-07-24 14:57:57 2024-07-24 11:57:57,855 |jsse-nio-8443-exec-4 |ConfigXMLReader               |I| controller loaded: 0.0s, 4 requests, 0 views in file:/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml 2024-07-24 14:57:57 2024-07-24 11:57:57,857 |jsse-nio-8443-exec-4 |JWTManager                    |I| Internal single sign on is disabled. 2024-07-24 14:57:57 2024-07-24 11:57:57,864 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| [ [ASync service started...- total:0.0,since last(Begin):0.0] ] - 'manufacturing / executeMrp' 2024-07-24 14:57:57 2024-07-24 11:57:57,912 |jsse-nio-8443-exec-4 |GenericAsyncEngine            |I| Persisted job queued : 1721822277909 2024-07-24 14:57:57 2024-07-24 11:57:57,912 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| [ [ASync service finished...- total:0.048,since last(ASync service sta...):0.048] ] - 'manufacturing / executeMrp' 2024-07-24 14:57:57 2024-07-24 11:57:57,915 |jsse-nio-8443-exec-4 |RequestHandler                |I| Ran Event service:async#executeMrp from [request] , result is [success] 2024-07-24 14:57:57 2024-07-24 11:57:57,916 |jsse-nio-8443-exec-4 |RequestHandler                |I| Rendering View [RunMrpGo] .  Hidden sessionId by default. 2024-07-24 14:57:57 2024-07-24 11:57:57,918 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getUserPreferenceGroup] finished in [1] milliseconds 2024-07-24 14:57:57 2024-07-24 11:57:57,940 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 4 screens in 0.016s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/MrpScreens.xml 2024-07-24 14:57:57 2024-07-24 11:57:57,955 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 2 screens in 0.012s from: file:/ofbiz/applications/manufacturing/widget/manufacturing/CommonScreens.xml 2024-07-24 14:57:57 2024-07-24 11:57:57,976 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 1 screens in 0.017s from: file:/ofbiz/applications/commonext/widget/CommonScreens.xml 2024-07-24 14:57:58 2024-07-24 11:57:58,074 |jsse-nio-8443-exec-4 |ServiceDispatcher             |T| Sync service [manufacturing/getLastSystemInfoNote] finished in [15] milliseconds 2024-07-24 14:57:58 2024-07-24 11:57:58,092 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 27 screens in 0.009s from: file:/ofbiz/framework/common/widget/CommonScreens.xml 2024-07-24 14:57:58 2024-07-24 11:57:58,166 |jsse-nio-8443-exec-4 |ScreenFactory                 |I| Got 26 screens in 0.019s from: file:/ofbiz/themes/common-theme/widget/CommonScreens.xml 2024-07-24 14:57:58 2024-07-24 11:57:58,380 |jsse-nio-8443-exec-4 |ServerHitBin                  |I| Visit delegatorName=default, ServerHitBin delegatorName=default 2024-07-24 14:57:58 2024-07-24 11:57:58,386 |jsse-nio-8443-exec-4 |ControlServlet                |T| [[ [runMrpGo(Domain:https://localhost)] Request Done- total:0.614,since last( [runMrpGo(Domain:...):0.614] ] 2024-07-24 14:58:13 2024-07-24 11:58:13,208 |OFBiz-JobQueue-1     |PersistedServiceJob           |I| Job   [1721822277909] Id [10017] – Next runtime: Wed Dec 31 23:59:59 UTC 1969 2024-07-24 14:58:13 2024-07-24 11:58:13,237 |OFBiz-JobQueue-1     |UtilObject                    |E| null 2024-07-24 14:58:13 java.io.InvalidClassException: filter status: REJECTED 2024-07-24 14:58:13 at java.io.ObjectInputStream.filterCheck(ObjectInputStream.java:1369) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readHandle(ObjectInputStream.java:1819) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readClassDesc(ObjectInputStream.java:1862) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readArray(ObjectInputStream.java:2089) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1675) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:489) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:447) ~ [?:?] 2024-07-24 14:58:13 at java.util.HashMap.readObject(HashMap.java:1466) ~ [?:?] 2024-07-24 14:58:13 at jdk.internal.reflect.GeneratedMethodAccessor322.invoke(Unknown Source) ~ [?:?] 2024-07-24 14:58:13 at jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~ [?:?] 2024-07-24 14:58:13 at java.lang.reflect.Method.invoke(Method.java:566) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectStreamClass.invokeReadObject(ObjectStreamClass.java:1046) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2357) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.defaultReadFields(ObjectInputStream.java:2496) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readSerialData(ObjectInputStream.java:2390) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readOrdinaryObject(ObjectInputStream.java:2228) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject0(ObjectInputStream.java:1687) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:489) ~ [?:?] 2024-07-24 14:58:13 at java.io.ObjectInputStream.readObject(ObjectInputStream.java:447) ~ [?:?] 2024-07-24 14:58:13 at org.apache.ofbiz.base.util.UtilObject.getObjectException(UtilObject.java:96) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.base.util.UtilObject.getObject(UtilObject.java:79) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:475) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~ [?:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~ [?:?] 2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~ [?:?] 2024-07-24 14:58:13 2024-07-24 11:58:13,238 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| PersistedServiceJob.getContext(): Serialize Exception 2024-07-24 14:58:13 org.apache.ofbiz.entity.serialize.SerializeException: Problem deserializing object from byte array + cus-obj 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeCustom(XmlSerializer.java:481) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:465) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserializeSingle(XmlSerializer.java:453) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:128) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.serialize.XmlSerializer.deserialize(XmlSerializer.java:102) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.PersistedServiceJob.getContext(PersistedServiceJob.java:319) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~ [?:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~ [?:?] 2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~ [?:?] 2024-07-24 14:58:13 2024-07-24 11:58:13,240 |OFBiz-JobQueue-1     |PersistedServiceJob           |E| Job context is null 2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |MrpServices                   |I| executeMrp called 2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |ServiceUtil                   |E| {errorMessage=facilityId and facilityGroupId cannot be both null, responseMessage=error} 2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |ServiceDispatcher             |E| Error in Service [executeMrp] : facilityId and facilityGroupId cannot be both null 2024-07-24 14:58:13 2024-07-24 11:58:13,242 |OFBiz-JobQueue-1     |TransactionUtil               |E| [TransactionUtil.rollback] 2024-07-24 14:58:13 java.lang.Exception: Stack Trace 2024-07-24 14:58:13 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:314) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:290) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:559) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:240) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.GenericDispatcherFactory$GenericDispatcher.runSync(GenericDispatcherFactory.java:88) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~ [?:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~ [?:?] 2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~ [?:?] 2024-07-24 14:58:13 2024-07-24 11:58:13,243 |OFBiz-JobQueue-1     |TransactionUtil               |I| Transaction rolled back 2024-07-24 14:58:13 2024-07-24 11:58:13,245 |OFBiz-JobQueue-1     |ServiceDispatcher             |T| Sync service [default/executeMrp] finished in [3] milliseconds 2024-07-24 14:58:13 2024-07-24 11:58:13,245 |OFBiz-JobQueue-1     |GenericServiceJob             |E| Async-Service failed. 2024-07-24 14:58:13 java.lang.Exception: facilityId and facilityGroupId cannot be both null 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:73) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at org.apache.ofbiz.service.job.AbstractJob.run(AbstractJob.java:87) ~ [ofbiz.jar:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~ [?:?] 2024-07-24 14:58:13 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~ [?:?] 2024-07-24 14:58:13 at java.lang.Thread.run(Thread.java:829) ~ [?:?] 2024-07-24 14:58:13 2024-07-24 11:58:13,245 |OFBiz-JobQueue-1     |PersistedServiceJob           |W| Persisted Job [10017] Failed. Max Retry Hit, not re-scheduling
            jleroux Jacques Le Roux added a comment - - edited

            I doubted it was a JDK issue, both 8 and 11 reject a data.

            So we now know for sure that there is a problem with data at some point. Else java.io.ObjectInputStream would not reject at least one before anything else is reported by the log.

            I see 2 possibilities.

            • Maybe you could extract the data you use locally? I'd try with them locally or on demo (trunk or 18.12 alike reject as we saw).
            • When I'll get a chance I'll try to follow Sharan's tuto locally on Ubuntu 20.04, to be able, if it works to try to extract the related data.

            Also in Nov. 2022, Yannong said:

            I set auth="false" for <service name="executeMrp" engine="java" ..> in service_mrp.xml to make it "work"

            when it did not work for you recently. It seems the version he used then allowed that. That could be a track to follow...

            jleroux Jacques Le Roux added a comment - - edited I doubted it was a JDK issue, both 8 and 11 reject a data. So we now know for sure that there is a problem with data at some point. Else java.io.ObjectInputStream would not reject at least one before anything else is reported by the log. I see 2 possibilities. Maybe you could extract the data you use locally? I'd try with them locally or on demo (trunk or 18.12 alike reject as we saw). When I'll get a chance I'll try to follow Sharan's tuto locally on Ubuntu 20.04, to be able, if it works to try to extract the related data. Also in Nov. 2022, Yannong said: I set auth="false" for <service name="executeMrp" engine="java" ..> in service_mrp.xml to make it "work" when it did not work for you recently. It seems the version he used then allowed that. That could be a track to follow...
            emad1967 Emad Radwan added a comment -

            The last try was with a fresh installation that I have Docker based where I
            only changed the JDK version on the dockerfile and I believe the only
            relevant piece of info is the facilityId which was 'WebStoreWarehouse'

            Regards,
            Emad

            On Thu, Jul 25, 2024 at 9:51 AM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - The last try was with a fresh installation that I have Docker based where I only changed the JDK version on the dockerfile and I believe the only relevant piece of info is the facilityId which was 'WebStoreWarehouse' Regards, Emad On Thu, Jul 25, 2024 at 9:51 AM Jacques Le Roux (Jira) <jira@apache.org>
            emad1967 Emad Radwan added a comment -

            something new I noticed while trying on https://demo-trunk.ofbiz.apache.org/manufacturing/control/FindInventoryEventPlan that when I tried with another facilityId it worked! but couldn't repeat that on my local version.

             

             

            emad1967 Emad Radwan added a comment - something new I noticed while trying on https://demo-trunk.ofbiz.apache.org/manufacturing/control/FindInventoryEventPlan that when I tried with another facilityId it worked! but couldn't repeat that on my local version.    

            I believe you used another facility at some point (maybe only one error) when creating the data following Sharan's tuto. That can be checked in the data as Omar suggested at https://lists.apache.org/thread/dnwsy7xwqh0gjbg3311269d1o1t8yhv6
            That would explain why picking the "right" facility and showing it in browser was not enough.

            jleroux Jacques Le Roux added a comment - I believe you used another facility at some point (maybe only one error) when creating the data following Sharan's tuto. That can be checked in the data as Omar suggested at https://lists.apache.org/thread/dnwsy7xwqh0gjbg3311269d1o1t8yhv6 That would explain why picking the "right" facility and showing it in browser was not enough.
            jleroux Jacques Le Roux added a comment - - edited

            It's though weird that one failed and the other succeded with an interval of 3 mins. Also that would mean that you created the data relying your raw products to another facility than the one suggested by Sharan's tuto?

            I looked at https://demo-trunk.ofbiz.apache.org/webtools/control/entity/find/Product but could not find any nail, wood or varnish products. How do you named your raw products? In this circumstance, too bad that the DB content is renewed every night :/

            jleroux Jacques Le Roux added a comment - - edited It's though weird that one failed and the other succeded with an interval of 3 mins. Also that would mean that you created the data relying your raw products to another facility than the one suggested by Sharan's tuto? I looked at https://demo-trunk.ofbiz.apache.org/webtools/control/entity/find/Product but could not find any nail, wood or varnish products. How do you named your raw products? In this circumstance, too bad that the DB content is renewed every night :/
            emad1967 Emad Radwan added a comment -

            I didn't enter the tutorial data, I just wanted to see the default
            behaviour. I assume the system would reply with a suitable error message if
            no enough data to work with not to fail with an error!

            Regards,
            Emad

            On Thu, Jul 25, 2024 at 8:21 PM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - I didn't enter the tutorial data, I just wanted to see the default behaviour. I assume the system would reply with a suitable error message if no enough data to work with not to fail with an error! Regards, Emad On Thu, Jul 25, 2024 at 8:21 PM Jacques Le Roux (Jira) <jira@apache.org>

            If you had said that intially it would have been much simpler.

            jleroux Jacques Le Roux added a comment - If you had said that intially it would have been much simpler.
            emad1967 Emad Radwan added a comment -

            I entered the tutorial data in the first time I reported the error and
            after I bypassed the authentication. What difference does this make?

            On Fri, Jul 26, 2024 at 12:11 PM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - I entered the tutorial data in the first time I reported the error and after I bypassed the authentication. What difference does this make? On Fri, Jul 26, 2024 at 12:11 PM Jacques Le Roux (Jira) <jira@apache.org>

            Sorry, I'm not sure to understand your question. I don't see the relation with authentication and data in DB.
            Once the data are in the DB, any user with sufficient permissions can use these data. Also I'm not sure what you mean by

            bypassed the authentication

            jleroux Jacques Le Roux added a comment - Sorry, I'm not sure to understand your question. I don't see the relation with authentication and data in DB. Once the data are in the DB, any user with sufficient permissions can use these data. Also I'm not sure what you mean by bypassed the authentication
            emad1967 Emad Radwan added a comment -

            In the other thread by Yannong in 2022 he mentioned that by trying to run MRP he first got an authentication error and when he set the security flag for the function false it did worked with him without getting the serialization error for the 'facilityId' but when I tried the same on my local installation - with tutorial data entered - I got the serialization error. I had to recreate the local docker image after that for several reasons and I used to text this functionality with new updates from you - like changing JDK - without re-entering the data as I didn't link that having enough configuration data is essential to avoid getting such error.

             

            I also went through the code 'executeMrp' and I don't think it does anything with the parameters passed - including facilityId - before raising the serialization error.

             

            Regards,

            Emad

            emad1967 Emad Radwan added a comment - In the other thread by Yannong in 2022 he mentioned that by trying to run MRP he first got an authentication error and when he set the security flag for the function false it did worked with him without getting the serialization error for the 'facilityId' but when I tried the same on my local installation - with tutorial data entered - I got the serialization error. I had to recreate the local docker image after that for several reasons and I used to text this functionality with new updates from you - like changing JDK - without re-entering the data as I didn't link that having enough configuration data is essential to avoid getting such error.   I also went through the code 'executeMrp' and I don't think it does anything with the parameters passed - including facilityId - before raising the serialization error.   Regards, Emad

            In the other thread by Yannong in 2022 he mentioned that by trying to run MRP he first got an authentication error and when he set the security flag for the function false it did worked with him without getting the serialization error for the 'facilityId' but when I tried the same on my local installation - with tutorial data entered - I got the serialization error.

            Yes, as I already said, the Yannong's situation and yours should not be compared because there have been changes since then. Not specifically related to MRP but that can have an impact on authentication (security changes).

            I had to recreate the local docker image after that for several reasons and I used to text this functionality with new updates from you - like changing JDK - without re-entering the data as I didn't link that having enough configuration data is essential to avoid getting such error.

            Yes indeed, if you reuse a MRP defined with previous created products but these products are no longer in the DB then you can't expect the MRP to run and that would explain why we get a serialization error.

            jleroux Jacques Le Roux added a comment - In the other thread by Yannong in 2022 he mentioned that by trying to run MRP he first got an authentication error and when he set the security flag for the function false it did worked with him without getting the serialization error for the 'facilityId' but when I tried the same on my local installation - with tutorial data entered - I got the serialization error. Yes, as I already said, the Yannong's situation and yours should not be compared because there have been changes since then. Not specifically related to MRP but that can have an impact on authentication (security changes). I had to recreate the local docker image after that for several reasons and I used to text this functionality with new updates from you - like changing JDK - without re-entering the data as I didn't link that having enough configuration data is essential to avoid getting such error. Yes indeed, if you reuse a MRP defined with previous created products but these products are no longer in the DB then you can't expect the MRP to run and that would explain why we get a serialization error.
            emad1967 Emad Radwan added a comment -

            for the second point, we're not talking about an existing MRP, I always try with a new one as I didn't ever reach the stage of having an MRP because it fails while creating it!

            emad1967 Emad Radwan added a comment - for the second point, we're not talking about an existing MRP, I always try with a new one as I didn't ever reach the stage of having an MRP because it fails while creating it!

            Do you strictly follow Sharan's tuto for creating your MRP? I did and it worked for me locally on both trunk and 18.12 (using the same Derby DB for both). Then running it was not a problem.

            jleroux Jacques Le Roux added a comment - Do you strictly follow Sharan's tuto for creating your MRP? I did and it worked for me locally on both trunk and 18.12 (using the same Derby DB for both). Then running it was not a problem.
            emad1967 Emad Radwan added a comment - - edited

            Do you mean that if do the tutorial on the stable demo version - forget about my installation for now - that it'll work? I want to see it working anywhere.

            emad1967 Emad Radwan added a comment - - edited Do you mean that if do the tutorial on the stable demo version - forget about my installation for now - that it'll work? I want to see it working anywhere.

            I did not try there, but I believe it will work. Remember that the data on demo are renewed each day around 3 UTC. So you have to create again a new MRP each day.

            Because we now use Docker on demo I don't know how to keep a copy of the Derby DB. A very practical thing that I can easily do locally.

            jleroux Jacques Le Roux added a comment - I did not try there, but I believe it will work. Remember that the data on demo are renewed each day around 3 UTC. So you have to create again a new MRP each day. Because we now use Docker on demo I don't know how to keep a copy of the Derby DB. A very practical thing that I can easily do locally.

            You were right to insist. I'm not sure yet but it seems that OFBIZ-12745 commit must be reverted too. At least by reverting it I was able to run again the MRPTable that has been created, with its data, 2 weeks ago (see above). It was not working else:

            Here is the patch:
            OFBIZ-12745-revert.patch

            Please confirm that after after applying the patch you are able to run MRPs with data created some times ago. This is for trunk only.

            If it's OK, we will need to consider finally what to do. Either keeping the workaround situation or correctly fixing OFBIZ-12745 and OFBIZ-10395. This should be discussed in dev ML.

            jleroux Jacques Le Roux added a comment - You were right to insist. I'm not sure yet but it seems that OFBIZ-12745 commit must be reverted too. At least by reverting it I was able to run again the MRPTable that has been created, with its data, 2 weeks ago (see above). It was not working else: Here is the patch: OFBIZ-12745-revert.patch Please confirm that after after applying the patch you are able to run MRPs with data created some times ago. This is for trunk only. If it's OK, we will need to consider finally what to do. Either keeping the workaround situation or correctly fixing OFBIZ-12745 and OFBIZ-10395 . This should be discussed in dev ML.
            emad1967 Emad Radwan added a comment -

            would you please give a hint on patch applying? I spent some time using the following but it fails.

             

            emadradwan@MacBook-Pro apache-ofbiz-18.12.13 % patch -p1 < ~/requirement_services_patch1.diff

             

            patching file 'applications/order/minilang/requirement/RequirementServices.xml'
            patch: **** malformed patch at line 9: http://ofbiz.apache.org/dtds/simple-methods.xsd">

            emad1967 Emad Radwan added a comment - would you please give a hint on patch applying? I spent some time using the following but it fails.   emadradwan@MacBook-Pro apache-ofbiz-18.12.13 % patch -p1 < ~/requirement_services_patch1.diff   patching file 'applications/order/minilang/requirement/RequirementServices.xml' patch: **** malformed patch at line 9: http://ofbiz.apache.org/dtds/simple-methods.xsd ">

            Hi,

            Yes, it's a git patch. Simply use at OFBiz framework root:

            git apply OFBIZ-12745-revert.patch
            
            jleroux Jacques Le Roux added a comment - Hi, Yes, it's a git patch. Simply use at OFBiz framework root: git apply OFBIZ-12745-revert.patch
            emad1967 Emad Radwan added a comment -

            the script references applications/order/src/main/groovy/org/apache/ofbiz/order/requirement/ that I don't have!
            in my directory and under 'applications/order/src/main' I have only a 'java' directory.

            emad1967 Emad Radwan added a comment - the script references applications/order/src/main/groovy/org/apache/ofbiz/order/requirement/ that I don't have! in my directory and under 'applications/order/src/main' I have only a 'java' directory.

            Hi,

            It's about trunk HEAD. There
            applications/order/src/main/groovy/org/apache/ofbiz/order/requirement/RequirementServicesScript.groovy
            is present:
            https://github.com/apache/ofbiz-framework/blob/1426f2c4236e8ebdece8efaa8be6e4b7c648b056/applications/order/src/main/groovy/org/apache/ofbiz/order/requirement/RequirementServicesScript.groovy

            jleroux Jacques Le Roux added a comment - Hi, It's about trunk HEAD. There applications/order/src/main/groovy/org/apache/ofbiz/order/requirement/RequirementServicesScript.groovy is present: https://github.com/apache/ofbiz-framework/blob/1426f2c4236e8ebdece8efaa8be6e4b7c648b056/applications/order/src/main/groovy/org/apache/ofbiz/order/requirement/RequirementServicesScript.groovy

            Hi Emad,

            What's the situation here?

            jleroux Jacques Le Roux added a comment - Hi Emad, What's the situation here?
            emad1967 Emad Radwan added a comment -

            Hi,

            I got it working on the trunk version but not locally.

            Regards,
            Emad

            On Wed, Nov 13, 2024 at 1:11 PM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - Hi, I got it working on the trunk version but not locally. Regards, Emad On Wed, Nov 13, 2024 at 1:11 PM Jacques Le Roux (Jira) <jira@apache.org>

            By locally you mean which version... and modified?

            jleroux Jacques Le Roux added a comment - By locally you mean which version... and modified?
            emad1967 Emad Radwan added a comment -

            Its version 18.12.13 and yes its modified with all of the hints we agreed
            on this thread to apply to fix the problem.

            Regards,
            Emad

            On Wed, Nov 13, 2024 at 2:37 PM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - Its version 18.12.13 and yes its modified with all of the hints we agreed on this thread to apply to fix the problem. Regards, Emad On Wed, Nov 13, 2024 at 2:37 PM Jacques Le Roux (Jira) <jira@apache.org>

            Could you please attach a patch with the changes?

            jleroux Jacques Le Roux added a comment - Could you please attach a patch with the changes?
            emad1967 Emad Radwan added a comment -

            How to obtain this?

            On Thu, Nov 14, 2024 at 11:08 AM Jacques Le Roux (Jira) <jira@apache.org>

            emad1967 Emad Radwan added a comment - How to obtain this? On Thu, Nov 14, 2024 at 11:08 AM Jacques Le Roux (Jira) <jira@apache.org>

            I mean only the code changes, data would be too complicated. So "git diff > changes.patch" and then attach changes.patch here.

            jleroux Jacques Le Roux added a comment - I mean only the code changes, data would be too complicated. So "git diff > changes.patch" and then attach changes.patch here.

            BTW, for security reason you should update your version when new releases appear. Soon will be 18.12.17: https://lists.apache.org/thread/l2v8gkr8sybodd4207437sokjxlzt8xm

            jleroux Jacques Le Roux added a comment - BTW, for security reason you should update your version when new releases appear. Soon will be 18.12.17: https://lists.apache.org/thread/l2v8gkr8sybodd4207437sokjxlzt8xm

            People

              jleroux Jacques Le Roux
              emad1967 Emad Radwan
              Votes:
              0 Vote for this issue
              Watchers:
              3 Start watching this issue

              Dates

                Created:
                Updated: