Unclear reason for startup after request Cancel The title field is required!

1. Markus Grigoleit

   

   31 posts
   Registered:
   04 Jun 2019
   14 Jun 2022

   Link to this post

   Hello again,
   
   we're using PASOE with SCL based rest-services under dlc 12.2.4.
   We defined 2 sessions/agents in the openedge.properties and we also see them getting started in the agent.log file. But as soon as we do the first request another agent will be started which can be quiet annoying while developing because all rest-services are listed again and this takes some time.
   
   It doesnt matter how many initial agents/session we define. The problem remains.
   
   Any ideas?
   
   022-06-14T11:33:55.320+0200 013768 017596 1 AS-7 ?:?:? Startup        ########################################################################
   2022-06-14T11:33:55.379+0200 013768 017596 1 AS-7 ?:?:? Managers       ########################################################################
   2022-06-14T11:33:55.391+0200 013768 017596 1 AS-7 ?:?:? Managers       ### Starting Manager: Ccs.Common.IServiceManager - Consultingwerk.Framework.CcsServiceManager
   2022-06-14T11:33:57.296+0200 013768 017596 1 AS-7 ?:?:? Startup        ### Setting 'Consultingwerk.SmartFramework.System.TranslationProvider:UseEmptyScopeAsFallback' to LOGICAL 'yes'
   2022-06-14T11:33:57.918+0200 013768 017596 1 AS-7 ?:?:? Startup        ### Setting 'Consultingwerk.Framework.FrameworkSettings:DebugMode' to LOGICAL 'no'
   2022-06-14T11:33:57.919+0200 013768 017596 1 AS-7 ?:?:? Startup        ### Setting 'Consultingwerk.OERA.DataAccess:LogFetchDataDetails' to LOGICAL 'no'
   2022-06-14T11:33:58.071+0200 013768 017596 1 AS-7 ?:?:? Startup        ### Setting 'Consultingwerk.Framework.ServiceContainer:VerboseLogging' to LOGICAL 'no'
   2022-06-14T11:34:16.145+0200 013768 017596 1 AS-7 ?:?:? APPL           Startup Validation succeeded.
   2022-06-14T11:34:16.145+0200 013768 017596 1 AS-7 ?:?:? APPL           **********************************************************
   2022-06-14T11:34:16.145+0200 013768 017596 1 AS-7 ?:?:? APPL           *** AppServer Startup Procedure finished.
   2022-06-14T11:34:16.145+0200 013768 017596 1 AS-7 ?:?:? APPL           **********************************************************
   2022-06-14T11:34:16.145+0200 013768 017596 1 AS-7 ?:?:? MSAS Successfully ran session startup procedure.
   2022-06-14T11:34:24.253+0200 013768 017596 1 AS-8 mtapsv:-:? -- Log entry types activated: ASPlumbing,DB.Connects
   2022-06-14T11:34:24.253+0200 013768 017596 2 AS-8 mtapsv:-:? AS Starting MSAS Session for pas79_logiweb.
   2022-06-14T11:34:24.253+0200 013768 017596 2 AS-8 mtapsv:-:? AS MSAS Session Start. (5473)
   2022-06-14T11:34:24.318+0200 013768 019008 1 AS-4 ROOT:f:00000001 APPL           >#># isHybridRealm: Start Validate User 1:service@consultingwerk (Tenant: 1, Username: service)
   2022-06-14T11:34:24.362+0200 013768 017596 2 AS-8 ?:?:? CONN           Datenbank dob Optionen:  (12699)
   2022-06-14T11:34:24.367+0200 013768 017596 2 AS-8 ?:?:? CONN           Mit Datenbank dob verbunden, Benutzernummer 6. (9543)
   2022-06-14T11:34:24.384+0200 013768 017596 2 AS-8 ?:?:? CONN           Datenbank SmartDB Optionen:  (12699)
   2022-06-14T11:34:24.389+0200 013768 017596 2 AS-8 ?:?:? CONN           Mit Datenbank SmartDB verbunden, Benutzernummer 6. (9543)
   2022-06-14T11:34:24.591+0200 013768 019008 1 AS-4 ROOT:f:00000001 APPL           >#># isHybridRealm: Validate Pwd Usrid: 1
   2022-06-14T11:34:24.593+0200 013768 019008 1 AS-4 ROOT:f:00000001 APPL           >#># isHybridRealm: PW OK
   2022-06-14T11:34:26.044+0200 013768 017596 1 AS-8 ?:?:? Startup        ########################################################################
   2022-06-14T11:34:26.875+0200 013768 017596 1 AS-8 ?:?:? LogManager     ### CustomLogEntries set to: LogManager
   2022-06-14T11:34:27.324+0200 013768 017596 1 AS-8 ?:?:? LogManager     ### CustomLogEntries set to: LogManager,ConfigurationFileParser
   2022-06-14T11:34:27.562+0200 013768 017596 1 AS-8 ?:?:? Configurat     ### Parsing Configuration File: IntegratedSystems/Framework/Server/is_startup_production.json
   2022-06-14T11:34:28.086+0200 013768 017596 1 AS-8 ?:?:? Configurat     ### Parsing Configuration File: Consultingwerk/Framework/Server/startup_common_appserver.json
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ########################################################################
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ### SmartComponent Library AppServer Agent Startup
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ### Framework Version: Release 11.7 #61847@2020-09-29 UTF-8
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ### OpenEdge Version:  12.2.4
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ### Agent Type: MULTI-SESSION-AGENT
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ### Working Directory: C:\Users\Markus.Grigoleit\_workspace\server\isag\dev\01\master\svc\pas79_logiweb\work
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ### (c)2008-2020 Consultingwerk Ltd. - All rights reserved.
   2022-06-14T11:34:28.404+0200 013768 017596 1 AS-8 ?:?:? SCL            ########################################################################
   
   
2. Mike Fechner

   

   342 posts
   Registered:
   14 Sep 2016
   14 Jun 2022 in reply to Markus Grigoleit

   Link to this post

   I don't see two agents. I only see one agent 013768
   
   That is launching three sessions (4, 7 and 8). 
   
   Most likely the startup of the initial sessions 4 and 7 (default are two initial sessions in openedge.properties) is taking too long and that's why the PASOE session manager starts a 3rd session. 
   
   
3. Markus Grigoleit

   

   31 posts
   Registered:
   04 Jun 2019
   14 Jun 2022 in reply to Mike Fechner

   Link to this post

   Mike Fechner said:
   Most likely the startup of the initial sessions 4 and 7 (default are two initial sessions in openedge.properties) is taking too long and that's why the PASOE session manager starts a 3rd session. 
   

   
   So how much time should it take to init a session? Are the Rest-Annotations loaded per session or per agent? Which param of the openedge.properties could i use to avoid a 3rd session?
4. Mike Fechner

   

   342 posts
   Registered:
   14 Sep 2016
   14 Jun 2022 in reply to Markus Grigoleit

   Link to this post

   Everything is per session. PASOE has no concept of sharing an data between sessions. 
   
   I'm sure there are max.... properties for sessions per agent in openedge.properties. Never looked at those.
5. Markus Grigoleit

   

   31 posts
   Registered:
   04 Jun 2019
   14 Jun 2022

   Link to this post

   So ive tried waiting 1 minute. Same result.
   
   I don't really understand how this works. The Startup procedure seems finished when the requests are made. Doesnt the  "appServer startup procedure finished." mark the successfully loaded session?
   And it uses the already started session to handle the request. (if i read the log correctly)
   
   

   Last modified on 14 Jun 2022 10:06 by Markus Grigoleit
6. Mike Fechner

   

   342 posts
   Registered:
   14 Sep 2016
   14 Jun 2022 in reply to Markus Grigoleit

   Link to this post

   I've tried this on 12.5. But I'm not aware if that would make a difference.
   
   When PASOE is started, it starts the sessions with the counters 4 and 7. The gap in the numbers is caused by an internal counter which is also used for other resources.
   
   When PASOE has started and the startup procedures (twice because 2 sessions) are finished it's not starting a third session for the first request. Session 4 serves the request. 
   
   Session 4 will server all requests while it's idle Session 7 will only be used when Session 4 is busy while a request is made. That's different to the round-robin strategy the classic AppServer uses for deciding which (single session) agent to use to serve a request. 
   
   But I only see a third session launched, when I produce some load.