CA Service Management

 View Only
  • 1.  xFlow login page not reachable

    Posted Jul 23, 2021 04:23 PM
    Hi,

    after adding a new Application Server to our environment, on which xFlow should be installed, we can not access the login page, which should be accessible via <server>:9002 for xFlow.
    Instead we get "page is not reachable" - "ERR_CONNECTION_REFUSED"

    The SDM service is up and running and we can reach the server in our Advance Availability environment correctly in the classic UI mode.

    The firewall is off and port 9002 is in the rule set nevertheless, but netstat don't show me a listening port.

    The xFlow service looks running fine in the Service control panel. But several log files show errors.
    Even on the server directly I cannot reach the login page. Not with servernamne, nor IP, nor localhost:9002

    The setup is an Advanced Availabilty SDM on 17.3.0.6 on Windows Server 2016 OS with remote MS SQL DB (SQL Sever 2016)
    1 BG
    1 SB
    3 App Servers


    I have restarted the whole environment already. And when starting xFlow on the 3rd App server at last, following log files get updated:

    xFlow\APPS\logs\xFlowService.log
    --------------------------------
    [2021-07-20 17:13:59] Log File Path = C:\PROGRA~1\CA\xFlow\APPS\\logs\xFlowService.log
    [2021-07-20 17:13:59] Starting Service - No. Of Arguments Passed: 1$Argument[0] = {C:\Program Files\CA\xFlow\APPS\ServiceConfig.xml}

    [2021-07-20 17:13:59] programfiles = C:\Program Files
    [2021-07-20 17:13:59] default JRE = C:\PROGRA~1\\CA\SC\jre\11.0.3
    [2021-07-20 17:13:59] Stopping Service - No. Of Arguments Passed: 2$Argument[0] = {C:\Program Files\CA\xFlow\APPS\ServiceConfig.xml}
    $Argument[1] = {LOCALSTOP}

    [2021-07-20 17:13:59] About to kill Incident Micro Service...
    [2021-07-20 17:13:59] About to kill Search Micro Service...
    [2021-07-20 17:13:59] About to kill Push Micro Service...
    [2021-07-20 17:13:59] About to kill Collab Micro Service...
    [2021-07-20 17:13:59] About to kill Insight Micro Service...
    [2021-07-20 17:13:59] Working Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\incidentmicroservice-17.0.479\bin
    [2021-07-20 17:13:59] App Home Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\incidentmicroservice-17.0.479
    [2021-07-20 17:13:59] Service Batch Path = C:\PROGRA~1\CA\xFlow\APPS\\Services\incidentmicroservice-17.0.479\bin\incidentmicroservice.bat
    [2021-07-20 17:13:59] Service PID File = C:\PROGRA~1\CA\xFlow\APPS\\Services\incidentmicroservice-17.0.479\bin\RUNNING_PID
    [2021-07-20 17:13:59] Service Port = 9002
    [2021-07-20 17:13:59] Starting Micro Service....
    [2021-07-20 17:13:59] Setting redirect output & error logs for the process....out =C:\PROGRA~1\CA\xFlow\APPS\\logs\incidentservicestdout.txt $ err =C:\PROGRA~1\CA\xFlow\APPS\\logs\incidentservicestderr.txt
    [2021-07-20 17:13:59] Micro Service Started
    [2021-07-20 17:14:02] Working Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\searchmicroservice-17.0.479\bin
    [2021-07-20 17:14:02] App Home Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\searchmicroservice-17.0.479
    [2021-07-20 17:14:02] Service Batch Path = C:\PROGRA~1\CA\xFlow\APPS\\Services\searchmicroservice-17.0.479\bin\searchmicroservice.bat
    [2021-07-20 17:14:02] Service PID File = C:\PROGRA~1\CA\xFlow\APPS\\Services\searchmicroservice-17.0.479\bin\RUNNING_PID
    [2021-07-20 17:14:02] Service Port = 9006
    [2021-07-20 17:14:02] Starting Micro Service....
    [2021-07-20 17:14:02] Setting redirect output & error logs for the process....out =C:\PROGRA~1\CA\xFlow\APPS\\logs\searchservicestdout.txt $ err =C:\PROGRA~1\CA\xFlow\APPS\\logs\searchservicestderr.txt
    [2021-07-20 17:14:02] Micro Service Started
    [2021-07-20 17:14:03] Working Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\pushmicroservice-17.0.479\bin
    [2021-07-20 17:14:03] App Home Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\pushmicroservice-17.0.479
    [2021-07-20 17:14:03] Service Batch Path = C:\PROGRA~1\CA\xFlow\APPS\\Services\pushmicroservice-17.0.479\bin\pushmicroservice.bat
    [2021-07-20 17:14:03] Service PID File = C:\PROGRA~1\CA\xFlow\APPS\\Services\pushmicroservice-17.0.479\bin\RUNNING_PID
    [2021-07-20 17:14:03] Service Port = 9008
    [2021-07-20 17:14:03] Starting Micro Service....
    [2021-07-20 17:14:04] Setting redirect output & error logs for the process....out =C:\PROGRA~1\CA\xFlow\APPS\\logs\pushservicestdout.txt $ err =C:\PROGRA~1\CA\xFlow\APPS\\logs\pushservicestderr.txt
    [2021-07-20 17:14:04] Micro Service Started
    [2021-07-20 17:14:05] Working Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\collabmicroservice-17.0.479\bin
    [2021-07-20 17:14:05] App Home Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\collabmicroservice-17.0.479
    [2021-07-20 17:14:05] Service Batch Path = C:\PROGRA~1\CA\xFlow\APPS\\Services\collabmicroservice-17.0.479\bin\collabmicroservice.bat
    [2021-07-20 17:14:05] Service PID File = C:\PROGRA~1\CA\xFlow\APPS\\Services\collabmicroservice-17.0.479\bin\RUNNING_PID
    [2021-07-20 17:14:05] Service Port = 9014
    [2021-07-20 17:14:05] Starting Micro Service....
    [2021-07-20 17:14:05] Setting redirect output & error logs for the process....out =C:\PROGRA~1\CA\xFlow\APPS\\logs\collabservicestdout.txt $ err =C:\PROGRA~1\CA\xFlow\APPS\\logs\collabservicestderr.txt
    [2021-07-20 17:14:05] Micro Service Started
    [2021-07-20 17:14:05] Working Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\insightmicroservice-17.1.706\bin
    [2021-07-20 17:14:05] App Home Directory = C:\PROGRA~1\CA\xFlow\APPS\\Services\insightmicroservice-17.1.706
    [2021-07-20 17:14:05] Service Batch Path = C:\PROGRA~1\CA\xFlow\APPS\\Services\insightmicroservice-17.1.706\bin\insightmicroservice.bat
    [2021-07-20 17:14:05] Service PID File = C:\PROGRA~1\CA\xFlow\APPS\\Services\insightmicroservice-17.1.706\bin\RUNNING_PID
    [2021-07-20 17:14:05] Service Port = 9016
    [2021-07-20 17:14:05] Starting Micro Service....
    [2021-07-20 17:14:05] Setting redirect output & error logs for the process....out =C:\PROGRA~1\CA\xFlow\APPS\\logs\insightservicestdout.txt $ err =C:\PROGRA~1\CA\xFlow\APPS\\logs\insightservicestderr.txt
    [2021-07-20 17:14:05] Micro Service Started



    xFlow\APPS\logs\commons-daemon.2021-07-20.log
    ---------------------------------------------
    [2021-07-20 17:13:58] [info] [ 6928] Commons Daemon procrun (1.0.15.0 64-bit) started
    [2021-07-20 17:13:58] [info] [ 6928] Running 'xFlowServer' Service...
    [2021-07-20 17:13:58] [info] [11084] Starting service...
    [2021-07-20 17:14:00] [info] [11084] Service started in 1249 ms.



    xFlow\APPS\logs\incidentMS.log
    ------------------------------
    INFO - 2021-07-20 17:14:03 [modules.IncidentMSModule] - Reading the Module Configurations.......
    INFO - 2021-07-20 17:14:18 [n.s.e.p.s.f.AnnotationSizeOfFilter] - Using regular expression provided through VM argument net.sf.ehcache.pool.sizeof.ignore.pattern for IgnoreSizeOf annotation : ^.*cache\..*IgnoreSizeOf$
    INFO - 2021-07-20 17:14:19 [n.s.e.pool.sizeof.JvmInformation] - Detected JVM data model settings of: 64-Bit OpenJDK JVM with Compressed OOPs
    INFO - 2021-07-20 17:14:19 [n.s.ehcache.pool.sizeof.AgentLoader] - Failed to attach to VM and load the agent: class java.io.IOException: Can not attach to current VM
    INFO - 2021-07-20 17:14:19 [n.s.e.pool.impl.DefaultSizeOfEngine] - using Unsafe sizeof engine
    INFO - 2021-07-20 17:14:19 [n.s.e.pool.impl.DefaultSizeOfEngine] - using Unsafe sizeof engine
    INFO - 2021-07-20 17:14:19 [n.s.e.pool.impl.DefaultSizeOfEngine] - using Unsafe sizeof engine
    INFO - 2021-07-20 17:14:19 [n.s.e.pool.impl.DefaultSizeOfEngine] - using Unsafe sizeof engine
    INFO - 2021-07-20 17:14:21 [akka.event.slf4j.Slf4jLogger] - Slf4jLogger started
    INFO - 2021-07-20 17:14:23 [application] - Connecting to Slump
    INFO - 2021-07-20 17:14:26 [global.GlobalApplicationSettings] - APP_CODE: 0
    INFO - 2021-07-20 17:14:26 [global.GlobalApplicationSettings] - APP_NAME: Incident MicroService
    INFO - 2021-07-20 17:14:26 [global.GlobalApplicationSettings] - APP_ROOT_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\incidentmicroservice-17.0.479\
    INFO - 2021-07-20 17:14:26 [global.GlobalApplicationSettings] - APP_LIB_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\incidentmicroservice-17.0.479\common\target\scala-2.12\classes;..\common\target\scala-2.12\classes;C:\PROGRA~1\CA\xFlow\APPS\Services\incidentmicroservice-17.0.479\lib\
    INFO - 2021-07-20 17:14:26 [global.GlobalApplicationSettings] - Generating SDM POJOs to location C:\PROGRA~1\CA\xFlow\APPS\\temp\CasmPlayApi\Source\Pojo\
    INFO - 2021-07-20 17:14:26 [com.ca.casm.utils.Utils] - The Service Desk environment is non-tenanted.
    INFO - 2021-07-20 17:14:26 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock acquired: true, is shared: false
    INFO - 2021-07-20 17:14:35 [com.ca.casm.sdm.SdmPojoProvider] - Skipping POJO generation as majic checksums match!
    INFO - 2021-07-20 17:14:43 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock released: true
    INFO - 2021-07-20 17:14:46 [global.GlobalApplicationSettings] - Unit Test ---> PriPOJO Entity Name = pri
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:encryptRoleID
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.audienceuris
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.enableManualRedirect
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.realm
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.reply
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.friendlyname
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.issuer
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.thumbprint
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:Incident_MicroService_akka.cluster.seed-nodes.0
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.context
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.domain
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.hostname
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.insightserver.name
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.requestimeout
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.theme
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.protocol
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:sso.secured.cookies
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - KD Settings: SUBMIT_COMMENTS = 1
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - KD Settings: VIEW_COMMENTS = 1
    INFO - 2021-07-20 17:14:47 [com.ca.casm.utils.Utils] - log4jPropFilePath: C:\PROGRA~1\CA\xFlow\APPS\Services\incidentmicroservice-17.0.479\\conf\log4j.properties
    INFO - 2021-07-20 17:14:47 [com.ca.casm.utils.Utils] - log4jRefreshInterval variable is null or empty. Defaulting the refresh interval to 300 seconds.
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - Started loading cache_info from database and ehcache.xml file.
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cache_info
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cache_info
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from CA SDM):itpam_tasks_info_cache#max#entry:25000
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from xml):my_context#max#entry:1
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_auth
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_auth
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache related to role authorization.
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for functional access role.
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_access
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - Total role objects : 46
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_access
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:dcon
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - Total func_access_role object count : 1664
    ERROR - 2021-07-20 17:14:47 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$12(CacheLoader.java:762)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for dcon
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for data partition.
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp_role
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - Total data partition record count is 178
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp_role
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type role.
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp
    INFO - 2021-07-20 17:14:47 [c.ca.casm.authorization.CacheLoader] - Total acctyp_role record count is 119
    INFO - 2021-07-20 17:14:47 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp
    INFO - 2021-07-20 17:14:48 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type objects.
    INFO - 2021-07-20 17:14:48 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:14:48 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: object_customized
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: bui_object_customized
    INFO - 2021-07-20 17:14:48 [c.ca.casm.authorization.Authorizer] - Register for changes initialization started for authorization module cache.
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: role
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: func_access_role
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: dcon
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tenant
    ERROR - 2021-07-20 17:14:48 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$16(CacheLoader.java:1106)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tenant
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tenant
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tgm_members
    ERROR - 2021-07-20 17:14:48 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$loadAccTypeCache$20(CacheLoader.java:1387)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tgm_members
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tgm_members
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cnt
    INFO - 2021-07-20 17:14:48 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cnt
    ERROR - 2021-07-20 17:14:51 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$18(CacheLoader.java:1249)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: cnt
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp_role
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: user_context
    INFO - 2021-07-20 17:14:51 [c.ca.casm.authorization.Authorizer] - Register for changes finished registration with SDM.
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: attr_control
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:master_data_cache
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for master_data_cache
    INFO - 2021-07-20 17:14:51 [c.c.c.a.cache.MasterDataCacheMgr] - Caching for master data factories is disabled.
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:stream_attrs
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for stream_attrs
    INFO - 2021-07-20 17:14:51 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: stream_eligible_attrs
    ERROR - 2021-07-20 17:14:52 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$14(CacheLoader.java:928)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:53 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:mytik_attr
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for mytik_attr
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: bui_mytickets_attrs
    INFO - 2021-07-20 17:14:54 [c.c.c.a.helper.bui.BuiConfigHelper] - Start loading Business user interface config properties from DB.
    INFO - 2021-07-20 17:14:54 [c.c.c.a.helper.bui.BuiConfigHelper] - Got count ( 0 ) bui_config records
    ERROR - 2021-07-20 17:14:54 [c.c.c.a.helper.bui.BuiConfigHelper] - No active records found for object bui_config. Returning -1
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:usp_apps
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for usp_apps
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: usp_apps
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:usp_app_acctyp
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for usp_app_acctyp
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: usp_app_acctyp
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:streams_cache
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for streams_cache
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: streams
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: cr_trans
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: crs
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: transition_type
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: in_trans
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: crs
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: transition_type
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: pr_trans
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: crs
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:notify_list_cache
    INFO - 2021-07-20 17:14:54 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for notify_list_cache
    ERROR - 2021-07-20 17:14:54 [c.helper.cache.TicketCacheManager] - Exception initializing ticket cache
    net.sf.ehcache.CacheException: No such search attribute [contactId] defined for this cache [notify_list_cache]
    at net.sf.ehcache.Cache.getSearchAttribute(Cache.java:3900)
    at controllers.helper.cache.TicketCacheManager.initContactNotifyListCache(TicketCacheManager.java:1325)
    at controllers.helper.cache.TicketCacheManager.init(TicketCacheManager.java:119)
    at global.GlobalApplicationSettings.<init>(GlobalApplicationSettings.java:182)
    at global.GlobalApplicationSettings$$FastClassByGuice$$66c47645.newInstance(<generated>)
    INFO - 2021-07-20 17:14:55 [com.ca.casm.actor.ClusterManager] - LocalHostName is : **********XFT.---FQDN---
    INFO - 2021-07-20 17:14:55 [com.ca.casm.actor.ClusterManager] - seedNodesMap: {akka.cluster.seed-nodes.0=akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551}
    INFO - 2021-07-20 17:14:55 [com.ca.casm.actor.ClusterManager] - Found nodeKey: akka.cluster.seed-nodes.0 from DB.
    INFO - 2021-07-20 17:14:59 [com.ca.casm.actor.ClusterManager] - Added cluster seed node: akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551
    INFO - 2021-07-20 17:14:59 [com.ca.casm.actor.ClusterManager] - We got an existing seed node: akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551 and the port is : 2551
    INFO - 2021-07-20 17:14:59 [com.ca.casm.actor.ClusterManager] - Seed Nodes are present in DB: {akka.cluster.seed-nodes.0=akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551}
    INFO - 2021-07-20 17:14:59 [com.ca.casm.actor.ClusterManager] - Cluster config defined as: {akka.actor.provider:"cluster",akka.remote.netty.tcp.hostname:"**********XFT.---FQDN---",akka.remote.netty.tcp.port:2551,akka.cluster.seed-nodes.0:"akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551",akka.extensions:["akka.cluster.pubsub.DistributedPubSub"]}
    INFO - 2021-07-20 17:15:00 [akka.event.slf4j.Slf4jLogger] - Slf4jLogger started
    INFO - 2021-07-20 17:15:00 [akka.remote.Remoting] - Starting remoting
    INFO - 2021-07-20 17:15:01 [akka.remote.Remoting] - Remoting started; listening on addresses :[akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551]
    INFO - 2021-07-20 17:15:01 [akka.remote.Remoting] - Remoting now listens on addresses: [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551]
    INFO - 2021-07-20 17:15:01 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Starting up, Akka version [2.5.19] ...
    INFO - 2021-07-20 17:15:01 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Registered cluster JMX MBean [akka:type=Cluster]
    INFO - 2021-07-20 17:15:01 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Started up successfully
    INFO - 2021-07-20 17:15:01 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:authentication-cache
    INFO - 2021-07-20 17:15:01 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] is JOINING itself (with roles [dc-default]) and forming new cluster
    INFO - 2021-07-20 17:15:01 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] dc [default] is the new leader
    INFO - 2021-07-20 17:15:01 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Leader is moving node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] to [Up]
    INFO - 2021-07-20 17:15:01 [a.c.s.ClusterSingletonManager] - Singleton manager starting singleton actor [akka://Incident_MicroService_XflowClusterSystem/user/removeIdleSessionsService/singleton]
    INFO - 2021-07-20 17:15:01 [a.c.s.ClusterSingletonManager] - ClusterSingletonManager state change [Start -> Oldest]
    ERROR - 2021-07-20 17:15:01 [c.c.c.a.s.SessionCleanUpThread] - Invalid value specified for SessionTimeout in conf file
    ERROR - 2021-07-20 17:15:01 [c.c.c.a.s.SessionCleanUpThread] - Invalid value specified for PeriodicallyUpdateLastAccessTime in conf file
    INFO - 2021-07-20 17:15:01 [c.c.c.a.s.SessionCleanUpThread] - Starting SessionCleanUpThread actor as a singleton...
    ERROR - 2021-07-20 17:15:01 [c.c.c.a.s.AuthenticationServiceSessionCache] - Invalid value specified for SessionTimeout in configuration
    INFO - 2021-07-20 17:15:02 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Marked address [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] as [Leaving]
    INFO - 2021-07-20 17:15:02 [a.c.s.ClusterSingletonManager] - Exited [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551]
    INFO - 2021-07-20 17:15:02 [a.c.s.ClusterSingletonManager] - Oldest observed OldestChanged: [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551 -> None]
    INFO - 2021-07-20 17:15:02 [a.c.s.ClusterSingletonManager] - ClusterSingletonManager state change [Oldest -> WasOldest]
    INFO - 2021-07-20 17:15:03 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Leader is moving node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] to [Exiting]
    INFO - 2021-07-20 17:15:04 [a.c.s.ClusterSingletonManager] - Singleton manager starting singleton actor [akka://Incident_MicroService_XflowClusterSystem/user/removeIdleSessionsService/singleton]
    INFO - 2021-07-20 17:15:04 [a.c.s.ClusterSingletonManager] - ClusterSingletonManager state change [WasOldest -> Stopping]
    INFO - 2021-07-20 17:15:04 [c.c.c.a.s.SessionCleanUpThread] - Stopping SessionCleanUpThread actor...
    INFO - 2021-07-20 17:15:04 [a.c.s.ClusterSingletonManager] - Singleton actor [akka://Incident_MicroService_XflowClusterSystem/user/removeIdleSessionsService/singleton] was terminated
    INFO - 2021-07-20 17:15:04 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Exiting completed
    INFO - 2021-07-20 17:15:04 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Shutting down...
    INFO - 2021-07-20 17:15:04 [a.c.Cluster(akka://Incident_MicroService_XflowClusterSystem)] - Cluster Node [akka.tcp://Incident_MicroService_XflowClusterSystem@**********XFT.---FQDN---:2551] - Successfully shut down
    INFO - 2021-07-20 17:15:05 [a.r.RemoteActorRefProvider$RemotingTerminator] - Shutting down remote daemon.
    INFO - 2021-07-20 17:15:05 [a.r.RemoteActorRefProvider$RemotingTerminator] - Remote daemon shut down; proceeding with flushing remote transports.
    INFO - 2021-07-20 17:15:05 [akka.remote.Remoting] - Remoting shut down
    INFO - 2021-07-20 17:15:05 [a.r.RemoteActorRefProvider$RemotingTerminator] - Remoting shut down.




    xFlow\APPS\logs\incidentMS_slump.log, xFlow\APPS\logs\insightMS_slump.log, xFlow\APPS\logs\searchMS_slump.log
    -------------------------------------------------------------------------------------------------------------
    07/20 17:14:23.332 [main] INFO Version 30 HV000001: Hibernate Validator 5.4.1.Final
    07/20 17:14:23.363 [main] WARN ParameterMessageInterpolator 28 HV000184: ParameterMessageInterpolator has been chosen, EL interpolation will not be supported
    07/20 17:14:23.722 [main] INFO NXenv 158 NX_ROOT was not found in the System Environment
    07/20 17:14:23.738 [main] INFO NXenv 177 NX_ROOT found in paradigm.ini
    07/20 17:14:23.738 [main] INFO NXenv 189 NX_ROOT = C:/PROGRA~2/CA/SERVIC~1
    07/20 17:14:23.753 [main] INFO SLUMP 133 Created SLUMP on **********XFT at port 2100
    07/20 17:14:23.753 [main] INFO TCP_port 169 Created standard port 2100 for **********XFT with id 1626794063753
    07/20 17:14:24.082 [main] INFO HEARTBEAT_SLNX 96 NX_SLUMP_HEARTBEAT_TIMEOUT set to 900 seconds
    07/20 17:14:24.488 [TCP_port-Read:Slump_nxd] INFO TCP_port 229 Created fastchannel port 2107 for null with id 1626794064488 between 1511118521.play_service_8168@**********XFT and 2435.domsrvr
    07/20 17:14:24.941 [TCP_port-Read:Slump_nxd] INFO TCP_port 229 Created fastchannel port 2106 for null with id 1626794064941 between 1511118521.play_service_8168@**********XFT and 2435.bpvirtdb_srvr
    07/20 17:14:47.066 [main] ERROR BPMessage 639 Attempt to getString argument 1 which is a Unknown





    xFlow\APPS\logs\incidentservicestderr.txt, xFlow\APPS\logs\insightservicestderr.txt, xFlow\APPS\logs\searchservicestderr.txt
    ----------------------------------------------------------------------------------------------------------------------------
    <empty>


    xFlow\APPS\logs\incidentservicestdout.txt, xFlow\APPS\logs\searchservicestdout.txt
    ------------------------------------------------------------------------------------
    <empty>





    xFlow\APPS\logs\collabMS.log
    ----------------------------
    INFO - 2021-07-20 17:14:14 [modules.CollaborationModule] - Fired the Collaboration Module Conf.......
    INFO - 2021-07-20 17:14:19 [akka.event.slf4j.Slf4jLogger] - Slf4jLogger started
    INFO - 2021-07-20 17:14:28 [n.s.e.p.s.f.AnnotationSizeOfFilter] - Using regular expression provided through VM argument net.sf.ehcache.pool.sizeof.ignore.pattern for IgnoreSizeOf annotation : ^.*cache\..*IgnoreSizeOf$
    INFO - 2021-07-20 17:14:29 [n.s.e.pool.sizeof.JvmInformation] - Detected JVM data model settings of: 64-Bit OpenJDK JVM with Compressed OOPs
    INFO - 2021-07-20 17:14:29 [n.s.ehcache.pool.sizeof.AgentLoader] - Failed to attach to VM and load the agent: class java.io.IOException: Can not attach to current VM
    INFO - 2021-07-20 17:14:29 [n.s.e.pool.impl.DefaultSizeOfEngine] - using Unsafe sizeof engine
    INFO - 2021-07-20 17:14:33 [application] - Connecting to Slump
    INFO - 2021-07-20 17:14:34 [global.GlobalApplicationSettings] - APP_CODE: 3
    INFO - 2021-07-20 17:14:34 [global.GlobalApplicationSettings] - APP_NAME: Collaboration MicroService
    INFO - 2021-07-20 17:14:34 [global.GlobalApplicationSettings] - APP_ROOT_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\collabmicroservice-17.0.479\
    INFO - 2021-07-20 17:14:34 [global.GlobalApplicationSettings] - APP_LIB_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\collabmicroservice-17.0.479\common\target\scala-2.12\classes;..\common\target\scala-2.12\classes;C:\PROGRA~1\CA\xFlow\APPS\Services\collabmicroservice-17.0.479\lib\
    INFO - 2021-07-20 17:14:34 [global.GlobalApplicationSettings] - Generating SDM POJOs to location C:\PROGRA~1\CA\xFlow\APPS\\temp\CasmPlayApi\Source\Pojo\
    INFO - 2021-07-20 17:14:34 [com.ca.casm.utils.Utils] - The Service Desk environment is non-tenanted.
    INFO - 2021-07-20 17:15:00 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock acquired: true, is shared: false
    INFO - 2021-07-20 17:15:09 [com.ca.casm.sdm.SdmPojoProvider] - Skipping POJO generation as majic checksums match!
    INFO - 2021-07-20 17:15:10 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock released: true
    INFO - 2021-07-20 17:15:12 [global.GlobalApplicationSettings] - Unit Test ---> PriPOJO Entity Name = pri
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:encryptRoleID
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.audienceuris
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.enableManualRedirect
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.realm
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.reply
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.friendlyname
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.issuer
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.thumbprint
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:Incident_MicroService_akka.cluster.seed-nodes.0
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.context
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.domain
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.hostname
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.insightserver.name
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.requestimeout
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.theme
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.protocol
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:sso.secured.cookies
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - KD Settings: SUBMIT_COMMENTS = 1
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - KD Settings: VIEW_COMMENTS = 1
    INFO - 2021-07-20 17:15:12 [com.ca.casm.utils.Utils] - log4jPropFilePath: C:\PROGRA~1\CA\xFlow\APPS\Services\collabmicroservice-17.0.479\\conf\log4j.properties
    INFO - 2021-07-20 17:15:12 [com.ca.casm.utils.Utils] - log4jRefreshInterval variable is null or empty. Defaulting the refresh interval to 300 seconds.
    INFO - 2021-07-20 17:15:12 [c.ca.casm.authorization.CacheLoader] - Started loading cache_info from database and ehcache.xml file.
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cache_info
    INFO - 2021-07-20 17:15:12 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cache_info
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from CA SDM):itpam_tasks_info_cache#max#entry:25000
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from xml):user_chat_session_cache#max#entry:2000
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from xml):bot_session#max#entry:10000
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_auth
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_auth
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache related to role authorization.
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for functional access role.
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_access
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - Total role objects : 46
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_access
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:dcon
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - Total func_access_role object count : 1664
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for dcon
    ERROR - 2021-07-20 17:15:13 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$12(CacheLoader.java:762)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for data partition.
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp_role
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - Total data partition record count is 178
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp_role
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type role.
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - Total acctyp_role record count is 119
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type objects.
    INFO - 2021-07-20 17:15:13 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:my_context
    INFO - 2021-07-20 17:15:13 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for my_context
    ERROR - 2021-07-20 17:15:13 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$loadAccTypeCache$20(CacheLoader.java:1387)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    ERROR - 2021-07-20 17:15:13 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$16(CacheLoader.java:1106)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    ERROR - 2021-07-20 17:15:14 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$18(CacheLoader.java:1249)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:14 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: object_customized
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: bui_object_customized
    INFO - 2021-07-20 17:15:14 [c.ca.casm.authorization.Authorizer] - Register for changes initialization started for authorization module cache.
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: role
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: func_access_role
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: dcon
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tenant
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tenant
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tenant
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tgm_members
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tgm_members
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tgm_members
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cnt
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cnt
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: cnt
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp_role
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: user_context
    INFO - 2021-07-20 17:15:14 [c.ca.casm.authorization.Authorizer] - Register for changes finished registration with SDM.
    INFO - 2021-07-20 17:15:14 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:master_data_cache
    INFO - 2021-07-20 17:15:15 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for master_data_cache
    ERROR - 2021-07-20 17:15:15 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$14(CacheLoader.java:928)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:15 [c.c.c.a.cache.MasterDataCacheMgr] - Caching for master data factories is disabled.
    INFO - 2021-07-20 17:15:15 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:authentication-cache
    ERROR - 2021-07-20 17:15:15 [c.c.c.a.s.AuthenticationServiceSessionCache] - Invalid value specified for SessionTimeout in configuration



    xFlow\APPS\logs\collabservicestderr.txt
    ---------------------------------------
    WARNING: An illegal reflective access operation has occurred
    WARNING: Illegal reflective access by com.google.inject.internal.cglib.core.$ReflectUtils$1 (file:/C:/Program%20Files/CA/xFlow/APPS/Services/collabmicroservice-17.0.479/lib/com.google.inject.guice-4.1.0.jar) to method java.lang.ClassLoader.defineClass(java.lang.String,byte[],int,int,java.security.ProtectionDomain)
    WARNING: Please consider reporting this to the maintainers of com.google.inject.internal.cglib.core.$ReflectUtils$1
    WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
    WARNING: All illegal access operations will be denied in a future release
    log4j:ERROR setFile(null,true) call failed.
    java.io.FileNotFoundException: =C:\PROGRA~1\CA\xFlow\APPS\logs\collabMS_slump.log (Die Syntax für den Dateinamen, Verzeichnisnamen oder die Datenträgerbezeichnung ist falsch)
    at java.base/java.io.FileOutputStream.open0(Native Method)
    at java.base/java.io.FileOutputStream.open(FileOutputStream.java:298)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:237)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:158)
    at org.apache.log4j.FileAppender.setFile(FileAppender.java:290)
    at org.apache.log4j.RollingFileAppender.setFile(RollingFileAppender.java:194)
    at org.apache.log4j.FileAppender.activateOptions(FileAppender.java:164)
    at org.apache.log4j.config.PropertySetter.activate(PropertySetter.java:257)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:133)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:97)
    at org.apache.log4j.PropertyConfigurator.parseAppender(PropertyConfigurator.java:689)
    at org.apache.log4j.PropertyConfigurator.parseCategory(PropertyConfigurator.java:647)
    at org.apache.log4j.PropertyConfigurator.configureRootCategory(PropertyConfigurator.java:544)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:440)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:476)
    at org.apache.log4j.helpers.OptionConverter.selectAndConfigure(OptionConverter.java:471)
    at org.apache.log4j.LogManager.<clinit>(LogManager.java:125)
    at java.base/java.lang.Class.forName0(Native Method)
    at java.base/java.lang.Class.forName(Class.java:398)
    at org.jboss.logging.LoggerProviders.tryLog4j(LoggerProviders.java:134)
    at org.jboss.logging.LoggerProviders.findProvider(LoggerProviders.java:96)
    at org.jboss.logging.LoggerProviders.find(LoggerProviders.java:34)
    at org.jboss.logging.LoggerProviders.<clinit>(LoggerProviders.java:31)
    at org.jboss.logging.Logger.getLogger(Logger.java:2465)
    at org.jboss.logging.Logger$1.run(Logger.java:2565)
    at java.base/java.security.AccessController.doPrivileged(Native Method)
    at org.jboss.logging.Logger.getMessageLogger(Logger.java:2529)
    at org.jboss.logging.Logger.getMessageLogger(Logger.java:2516)
    at org.hibernate.validator.internal.util.logging.LoggerFactory.make(LoggerFactory.java:19)
    at org.hibernate.validator.internal.util.Version.<clinit>(Version.java:22)
    at org.hibernate.validator.internal.engine.ConfigurationImpl.<clinit>(ConfigurationImpl.java:71)
    at org.hibernate.validator.HibernateValidator.createGenericConfiguration(HibernateValidator.java:33)
    at javax.validation.Validation$GenericBootstrapImpl.configure(Validation.java:276)
    at play.data.validation.ValidatorProvider.<init>(ValidatorProvider.java:27)
    at play.data.validation.ValidatorProvider$$FastClassByGuice$$580fd498.newInstance(<generated>)
    at com.google.inject.internal.DefaultConstructionProxyFactory$FastClassProxy.newInstance(DefaultConstructionProxyFactory.java:89)
    at com.google.inject.internal.ConstructorInjector.provision(ConstructorInjector.java:111)
    at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:90)
    at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:268)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:61)
    at com.google.inject.internal.SingleParameterInjector.inject(SingleParameterInjector.java:38)
    at com.google.inject.internal.SingleParameterInjector.getAll(SingleParameterInjector.java:62)
    at com.google.inject.internal.ConstructorInjector.provision(ConstructorInjector.java:110)
    at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:90)
    at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:268)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:205)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1085)
    at com.google.inject.internal.InternalInjectorCreator.loadEagerSingletons(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:180)
    at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:110)
    at com.google.inject.Guice.createInjector(Guice.java:99)
    at com.google.inject.Guice.createInjector(Guice.java:84)
    at play.api.inject.guice.GuiceBuilder.injector(GuiceInjectorBuilder.scala:185)
    at play.api.inject.guice.GuiceApplicationBuilder.build(GuiceApplicationBuilder.scala:137)
    at play.api.inject.guice.GuiceApplicationLoader.load(GuiceApplicationLoader.scala:21)
    at play.core.server.ProdServerStart$.start(ProdServerStart.scala:51)
    at play.core.server.ProdServerStart$.main(ProdServerStart.scala:25)
    at play.core.server.ProdServerStart.main(ProdServerStart.scala)
    log4j:ERROR setFile(null,true) call failed.
    java.io.FileNotFoundException: =C:\PROGRA~1\CA\xFlow\APPS\logs\collabMS_slump.log (Die Syntax für den Dateinamen, Verzeichnisnamen oder die Datenträgerbezeichnung ist falsch)
    at java.base/java.io.FileOutputStream.open0(Native Method)
    at java.base/java.io.FileOutputStream.open(FileOutputStream.java:298)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:237)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:158)
    at org.apache.log4j.FileAppender.setFile(FileAppender.java:290)
    at org.apache.log4j.RollingFileAppender.setFile(RollingFileAppender.java:194)
    at org.apache.log4j.FileAppender.activateOptions(FileAppender.java:164)
    at org.apache.log4j.config.PropertySetter.activate(PropertySetter.java:257)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:133)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:97)
    at org.apache.log4j.PropertyConfigurator.parseAppender(PropertyConfigurator.java:689)
    at org.apache.log4j.PropertyConfigurator.parseCategory(PropertyConfigurator.java:647)
    at org.apache.log4j.PropertyConfigurator.configureRootCategory(PropertyConfigurator.java:544)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:440)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:334)



    xFlow\APPS\logs\collabservicestdout.txt
    ---------------------------------------
    17:14:12,457 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
    17:14:12,457 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
    17:14:12,457 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/Program%20Files/CA/xFlow/APPS/Services/collabmicroservice-17.0.479/conf/logback.xml]
    17:14:12,831 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
    17:14:12,863 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/C:/Program%20Files/CA/xFlow/APPS/Services/collabmicroservice-17.0.479/conf/logback.xml]
    17:14:12,863 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 minutes
    17:14:12,863 |-INFO in ch.qos.logback.core.joran.action.ConversionRuleAction - registering conversion word coloredLevel with class [play.api.libs.logback.ColoredLevel]
    17:14:12,863 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
    17:14:12,878 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
    17:14:12,894 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@24:79 - no applicable action for [rollingPolicy], current ElementPath is [[configuration][appender][rollingPolicy]]
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@26:26 - no applicable action for [fileNamePattern], current ElementPath is [[configuration][appender][rollingPolicy][fileNamePattern]]
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@27:107 - no applicable action for [timeBasedFileNamingAndTriggeringPolicy], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy]]
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@28:26 - no applicable action for [maxFileSize], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy][maxFileSize]]
    17:14:12,972 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@31:21 - no applicable action for [maxHistory], current ElementPath is [[configuration][appender][rollingPolicy][maxHistory]]
    17:14:12,972 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS.log]
    17:14:12,972 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:13,316 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CHATANALYZER]
    17:14:13,378 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:13,441 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1717739363 - Archive files will be limited to [30 MB] each.
    17:14:13,441 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1717739363 - No compression will be used
    17:14:13,441 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1717739363 - Will use the pattern C:/PROGRA~1/CA/xFlow/APPS//logs/user_chat_%d{yyyy-MM-dd}_%i.log for the active file
    17:14:13,441 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@841e575 - The date pattern is 'yyyy-MM-dd' from file name pattern 'C:/PROGRA~1/CA/xFlow/APPS//logs/user_chat_%d{yyyy-MM-dd}_%i.log'.
    17:14:13,441 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@841e575 - Roll-over at midnight.
    17:14:13,472 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@841e575 - Setting initial period to Tue Jul 20 11:12:51 CEST 2021
    17:14:13,472 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CHATANALYZER] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/user_chat.log
    17:14:13,472 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CHATANALYZER] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/user_chat.log]
    17:14:13,472 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNCFILE]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to ch.qos.logback.classic.AsyncAppender[ASYNCFILE]
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Attaching appender named [FILE] to AsyncAppender.
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Setting discardingThreshold to 51
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNC_CHAT_ANALYZER]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CHATANALYZER] to ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER]
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Attaching appender named [CHATANALYZER] to AsyncAppender.
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Setting discardingThreshold to 51
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DEBUGFILE]
    17:14:13,503 |-INFO in ch.qos.logback.core.rolling.FixedWindowRollingPolicy@27a5328c - No compression will be used
    17:14:13,503 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS_debug.log
    17:14:13,503 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS_debug.log]
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [play] to INFO
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [application] to INFO
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [ChatAnalyzer] to INFO
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [ChatAnalyzer] to false
    17:14:13,503 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNC_CHAT_ANALYZER] to Logger[ChatAnalyzer]
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebean.config.PropertyMapLoader] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.core.XmlConfigLoader] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.lib.BackgroundThread] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.gargoylesoftware.htmlunit.javascript] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
    17:14:13,503 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNCFILE] to Logger[ROOT]
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@1e5f4170 - Registering current configuration as safe fallback point

    17:14:12,457 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
    17:14:12,457 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
    17:14:12,457 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/Program%20Files/CA/xFlow/APPS/Services/collabmicroservice-17.0.479/conf/logback.xml]
    17:14:12,831 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
    17:14:12,863 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/C:/Program%20Files/CA/xFlow/APPS/Services/collabmicroservice-17.0.479/conf/logback.xml]
    17:14:12,863 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 minutes
    17:14:12,863 |-INFO in ch.qos.logback.core.joran.action.ConversionRuleAction - registering conversion word coloredLevel with class [play.api.libs.logback.ColoredLevel]
    17:14:12,863 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
    17:14:12,878 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
    17:14:12,894 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@24:79 - no applicable action for [rollingPolicy], current ElementPath is [[configuration][appender][rollingPolicy]]
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@26:26 - no applicable action for [fileNamePattern], current ElementPath is [[configuration][appender][rollingPolicy][fileNamePattern]]
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@27:107 - no applicable action for [timeBasedFileNamingAndTriggeringPolicy], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy]]
    17:14:12,956 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@28:26 - no applicable action for [maxFileSize], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy][maxFileSize]]
    17:14:12,972 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@31:21 - no applicable action for [maxHistory], current ElementPath is [[configuration][appender][rollingPolicy][maxHistory]]
    17:14:12,972 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS.log]
    17:14:12,972 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:13,316 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CHATANALYZER]
    17:14:13,378 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:13,441 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1717739363 - Archive files will be limited to [30 MB] each.
    17:14:13,441 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1717739363 - No compression will be used
    17:14:13,441 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@1717739363 - Will use the pattern C:/PROGRA~1/CA/xFlow/APPS//logs/user_chat_%d{yyyy-MM-dd}_%i.log for the active file
    17:14:13,441 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@841e575 - The date pattern is 'yyyy-MM-dd' from file name pattern 'C:/PROGRA~1/CA/xFlow/APPS//logs/user_chat_%d{yyyy-MM-dd}_%i.log'.
    17:14:13,441 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@841e575 - Roll-over at midnight.
    17:14:13,472 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@841e575 - Setting initial period to Tue Jul 20 11:12:51 CEST 2021
    17:14:13,472 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CHATANALYZER] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/user_chat.log
    17:14:13,472 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CHATANALYZER] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/user_chat.log]
    17:14:13,472 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNCFILE]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to ch.qos.logback.classic.AsyncAppender[ASYNCFILE]
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Attaching appender named [FILE] to AsyncAppender.
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Setting discardingThreshold to 51
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNC_CHAT_ANALYZER]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CHATANALYZER] to ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER]
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Attaching appender named [CHATANALYZER] to AsyncAppender.
    17:14:13,488 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Setting discardingThreshold to 51
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:13,488 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DEBUGFILE]
    17:14:13,503 |-INFO in ch.qos.logback.core.rolling.FixedWindowRollingPolicy@27a5328c - No compression will be used
    17:14:13,503 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS_debug.log
    17:14:13,503 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS_debug.log]
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [play] to INFO
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [application] to INFO
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [ChatAnalyzer] to INFO
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [ChatAnalyzer] to false
    17:14:13,503 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNC_CHAT_ANALYZER] to Logger[ChatAnalyzer]
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebean.config.PropertyMapLoader] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.core.XmlConfigLoader] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.lib.BackgroundThread] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.gargoylesoftware.htmlunit.javascript] to OFF
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
    17:14:13,503 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNCFILE] to Logger[ROOT]
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
    17:14:13,503 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@1e5f4170 - Registering current configuration as safe fallback point
    17:14:13,644 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Worker thread will flush remaining events before exiting.
    17:14:13,910 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Queue flush finished successfully within timeout.
    17:14:13,910 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Worker thread will flush remaining events before exiting.
    17:14:13,910 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Queue flush finished successfully within timeout.
    17:14:13,925 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
    17:14:13,925 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/C:/Program%20Files/CA/xFlow/APPS/Services/collabmicroservice-17.0.479/conf/logback.xml]
    17:14:13,925 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 minutes
    17:14:14,160 |-INFO in ch.qos.logback.core.joran.action.ConversionRuleAction - registering conversion word coloredLevel with class [play.api.libs.logback.ColoredLevel]
    17:14:14,160 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
    17:14:14,160 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
    17:14:14,160 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:14,160 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@24:79 - no applicable action for [rollingPolicy], current ElementPath is [[configuration][appender][rollingPolicy]]
    17:14:14,160 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@26:26 - no applicable action for [fileNamePattern], current ElementPath is [[configuration][appender][rollingPolicy][fileNamePattern]]
    17:14:14,160 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@27:107 - no applicable action for [timeBasedFileNamingAndTriggeringPolicy], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy]]
    17:14:14,160 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@28:26 - no applicable action for [maxFileSize], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy][maxFileSize]]
    17:14:14,160 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@31:21 - no applicable action for [maxHistory], current ElementPath is [[configuration][appender][rollingPolicy][maxHistory]]
    17:14:14,160 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS.log]
    17:14:14,160 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:14,160 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CHATANALYZER]
    17:14:14,160 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:14,160 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@2031927175 - Archive files will be limited to [30 MB] each.
    17:14:14,160 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@2031927175 - No compression will be used
    17:14:14,160 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@2031927175 - Will use the pattern C:/PROGRA~1/CA/xFlow/APPS//logs/user_chat_%d{yyyy-MM-dd}_%i.log for the active file
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@a7e2d9d - The date pattern is 'yyyy-MM-dd' from file name pattern 'C:/PROGRA~1/CA/xFlow/APPS//logs/user_chat_%d{yyyy-MM-dd}_%i.log'.
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@a7e2d9d - Roll-over at midnight.
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@a7e2d9d - Setting initial period to Tue Jul 20 11:12:51 CEST 2021
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CHATANALYZER] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/user_chat.log
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[CHATANALYZER] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/user_chat.log]
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNCFILE]
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to ch.qos.logback.classic.AsyncAppender[ASYNCFILE]
    17:14:14,175 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Attaching appender named [FILE] to AsyncAppender.
    17:14:14,175 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Setting discardingThreshold to 51
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNC_CHAT_ANALYZER]
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CHATANALYZER] to ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER]
    17:14:14,175 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Attaching appender named [CHATANALYZER] to AsyncAppender.
    17:14:14,175 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNC_CHAT_ANALYZER] - Setting discardingThreshold to 51
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:14,175 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DEBUGFILE]
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.FixedWindowRollingPolicy@754777cd - No compression will be used
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS_debug.log
    17:14:14,175 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/collabMS_debug.log]
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [play] to INFO
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [application] to INFO
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [ChatAnalyzer] to INFO
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [ChatAnalyzer] to false
    17:14:14,191 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNC_CHAT_ANALYZER] to Logger[ChatAnalyzer]
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebean.config.PropertyMapLoader] to OFF
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.core.XmlConfigLoader] to OFF
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.lib.BackgroundThread] to OFF
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.gargoylesoftware.htmlunit.javascript] to OFF
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
    17:14:14,191 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNCFILE] to Logger[ROOT]
    17:14:14,191 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.




    xFlow\APPS\logs\insightMS.log
    -----------------------------
    INFO - 2021-07-20 17:14:38 [modules.InsightMSModule] - Reading the Module Configurations.......
    INFO - 2021-07-20 17:14:41 [akka.event.slf4j.Slf4jLogger] - Slf4jLogger started
    INFO - 2021-07-20 17:14:47 [application] - Connecting to Slump
    INFO - 2021-07-20 17:14:47 [global.GlobalApplicationSettings] - APP_CODE: 4
    INFO - 2021-07-20 17:14:47 [global.GlobalApplicationSettings] - APP_NAME: Insight MicroService
    INFO - 2021-07-20 17:14:47 [global.GlobalApplicationSettings] - APP_ROOT_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\insightmicroservice-17.1.706\
    INFO - 2021-07-20 17:14:47 [global.GlobalApplicationSettings] - APP_LIB_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\insightmicroservice-17.1.706\common\target\scala-2.12\classes;..\common\target\scala-2.12\classes;C:\PROGRA~1\CA\xFlow\APPS\Services\insightmicroservice-17.1.706\lib\
    INFO - 2021-07-20 17:14:47 [global.GlobalApplicationSettings] - Generating SDM POJOs to location C:\PROGRA~1\CA\xFlow\APPS\\temp\CasmPlayApi\Source\Pojo\
    INFO - 2021-07-20 17:14:47 [com.ca.casm.utils.Utils] - The Service Desk environment is non-tenanted.
    INFO - 2021-07-20 17:15:09 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock acquired: true, is shared: false
    INFO - 2021-07-20 17:15:16 [com.ca.casm.sdm.SdmPojoProvider] - Skipping POJO generation as majic checksums match!
    INFO - 2021-07-20 17:15:17 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock released: true
    INFO - 2021-07-20 17:15:18 [global.GlobalApplicationSettings] - Unit Test ---> PriPOJO Entity Name = pri
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:encryptRoleID
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.audienceuris
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.enableManualRedirect
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.realm
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.reply
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.friendlyname
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.issuer
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.thumbprint
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:Incident_MicroService_akka.cluster.seed-nodes.0
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.context
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.domain
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.hostname
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.insightserver.name
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.requestimeout
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.theme
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.protocol
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:sso.secured.cookies
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - KD Settings: SUBMIT_COMMENTS = 1
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - KD Settings: VIEW_COMMENTS = 1
    INFO - 2021-07-20 17:15:18 [com.ca.casm.utils.Utils] - log4jPropFilePath: C:\PROGRA~1\CA\xFlow\APPS\Services\insightmicroservice-17.1.706\\conf\log4j.properties
    INFO - 2021-07-20 17:15:18 [com.ca.casm.utils.Utils] - log4jRefreshInterval variable is null or empty. Defaulting the refresh interval to 300 seconds.
    INFO - 2021-07-20 17:15:18 [c.ca.casm.authorization.CacheLoader] - Started loading cache_info from database and ehcache.xml file.
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cache_info
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cache_info
    INFO - 2021-07-20 17:15:18 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from CA SDM):itpam_tasks_info_cache#max#entry:25000
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_auth
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_auth
    INFO - 2021-07-20 17:15:18 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache related to role authorization.
    INFO - 2021-07-20 17:15:18 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for functional access role.
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_access
    INFO - 2021-07-20 17:15:18 [c.ca.casm.authorization.CacheLoader] - Total role objects : 46
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_access
    INFO - 2021-07-20 17:15:18 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:dcon
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - Total func_access_role object count : 1664
    ERROR - 2021-07-20 17:15:19 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$12(CacheLoader.java:762)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for dcon
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for data partition.
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp_role
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - Total data partition record count is 178
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp_role
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type role.
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - Total acctyp_role record count is 119
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type objects.
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:my_context
    ERROR - 2021-07-20 17:15:19 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$16(CacheLoader.java:1106)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    ERROR - 2021-07-20 17:15:19 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$18(CacheLoader.java:1249)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for my_context
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: object_customized
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: bui_object_customized
    INFO - 2021-07-20 17:15:19 [c.ca.casm.authorization.Authorizer] - Register for changes initialization started for authorization module cache.
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: role
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: func_access_role
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: dcon
    INFO - 2021-07-20 17:15:19 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tenant
    ERROR - 2021-07-20 17:15:20 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$loadAccTypeCache$20(CacheLoader.java:1387)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tenant
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tenant
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tgm_members
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tgm_members
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tgm_members
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cnt
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cnt
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: cnt
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp_role
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: user_context
    INFO - 2021-07-20 17:15:20 [c.ca.casm.authorization.Authorizer] - Register for changes finished registration with SDM.
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:master_data_cache
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for master_data_cache
    INFO - 2021-07-20 17:15:20 [c.c.c.a.cache.MasterDataCacheMgr] - Caching for master data factories is disabled.
    INFO - 2021-07-20 17:15:20 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:authentication-cache
    ERROR - 2021-07-20 17:15:20 [c.c.c.a.s.AuthenticationServiceSessionCache] - Invalid value specified for SessionTimeout in configuration




    xFlow\APPS\logs\insightservicestdout.txt
    -----------------------------------------
    17:14:37,410 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
    17:14:37,410 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
    17:14:37,410 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/Program%20Files/CA/xFlow/APPS/Services/insightmicroservice-17.1.706/conf/logback.xml]
    17:14:37,722 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
    17:14:37,738 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/C:/Program%20Files/CA/xFlow/APPS/Services/insightmicroservice-17.1.706/conf/logback.xml]
    17:14:37,738 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 minutes
    17:14:37,754 |-INFO in ch.qos.logback.core.joran.action.ConversionRuleAction - registering conversion word coloredLevel with class [play.api.libs.logback.ColoredLevel]
    17:14:37,754 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
    17:14:37,754 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
    17:14:37,769 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@24:79 - no applicable action for [rollingPolicy], current ElementPath is [[configuration][appender][rollingPolicy]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@26:26 - no applicable action for [fileNamePattern], current ElementPath is [[configuration][appender][rollingPolicy][fileNamePattern]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@27:107 - no applicable action for [timeBasedFileNamingAndTriggeringPolicy], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@28:26 - no applicable action for [maxFileSize], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy][maxFileSize]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@31:21 - no applicable action for [maxHistory], current ElementPath is [[configuration][appender][rollingPolicy][maxHistory]]
    17:14:37,816 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/insightMS.log]
    17:14:37,816 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:37,816 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNCFILE]
    17:14:37,816 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to ch.qos.logback.classic.AsyncAppender[ASYNCFILE]
    17:14:37,816 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Attaching appender named [FILE] to AsyncAppender.
    17:14:37,816 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Setting discardingThreshold to 51
    17:14:37,816 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:37,816 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DEBUGFILE]
    17:14:37,832 |-INFO in ch.qos.logback.core.rolling.FixedWindowRollingPolicy@6273c5a4 - No compression will be used
    17:14:37,832 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/insightMS_debug.log
    17:14:37,832 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/insightMS_debug.log]
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [play] to INFO
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [application] to INFO
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebean.config.PropertyMapLoader] to OFF
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.core.XmlConfigLoader] to OFF
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.lib.BackgroundThread] to OFF
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.gargoylesoftware.htmlunit.javascript] to OFF
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
    17:14:37,832 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNCFILE] to Logger[ROOT]
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
    17:14:37,832 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@5d465e4b - Registering current configuration as safe fallback point

    17:14:37,410 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
    17:14:37,410 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
    17:14:37,410 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/Program%20Files/CA/xFlow/APPS/Services/insightmicroservice-17.1.706/conf/logback.xml]
    17:14:37,722 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
    17:14:37,738 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/C:/Program%20Files/CA/xFlow/APPS/Services/insightmicroservice-17.1.706/conf/logback.xml]
    17:14:37,738 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 minutes
    17:14:37,754 |-INFO in ch.qos.logback.core.joran.action.ConversionRuleAction - registering conversion word coloredLevel with class [play.api.libs.logback.ColoredLevel]
    17:14:37,754 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
    17:14:37,754 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
    17:14:37,769 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@24:79 - no applicable action for [rollingPolicy], current ElementPath is [[configuration][appender][rollingPolicy]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@26:26 - no applicable action for [fileNamePattern], current ElementPath is [[configuration][appender][rollingPolicy][fileNamePattern]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@27:107 - no applicable action for [timeBasedFileNamingAndTriggeringPolicy], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@28:26 - no applicable action for [maxFileSize], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy][maxFileSize]]
    17:14:37,816 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@31:21 - no applicable action for [maxHistory], current ElementPath is [[configuration][appender][rollingPolicy][maxHistory]]
    17:14:37,816 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/insightMS.log]






    xFlow\APPS\logs\pushMS.log
    ----------------------------
    INFO - 2021-07-20 17:14:24 [n.s.e.p.s.f.AnnotationSizeOfFilter] - Using regular expression provided through VM argument net.sf.ehcache.pool.sizeof.ignore.pattern for IgnoreSizeOf annotation : ^.*cache\..*IgnoreSizeOf$
    INFO - 2021-07-20 17:14:24 [n.s.e.pool.sizeof.JvmInformation] - Detected JVM data model settings of: 64-Bit OpenJDK JVM with Compressed OOPs
    INFO - 2021-07-20 17:14:25 [n.s.ehcache.pool.sizeof.AgentLoader] - Failed to attach to VM and load the agent: class java.io.IOException: Can not attach to current VM
    INFO - 2021-07-20 17:14:25 [n.s.e.pool.impl.DefaultSizeOfEngine] - using Unsafe sizeof engine
    INFO - 2021-07-20 17:14:25 [n.s.e.pool.impl.DefaultSizeOfEngine] - using Unsafe sizeof engine
    INFO - 2021-07-20 17:14:28 [akka.event.slf4j.Slf4jLogger] - Slf4jLogger started
    INFO - 2021-07-20 17:14:31 [application] - Connecting to Slump
    INFO - 2021-07-20 17:14:33 [global.GlobalApplicationSettings] - APP_CODE: 2
    INFO - 2021-07-20 17:14:33 [global.GlobalApplicationSettings] - APP_NAME: Push MicroService
    INFO - 2021-07-20 17:14:33 [global.GlobalApplicationSettings] - APP_ROOT_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\pushmicroservice-17.0.479\
    INFO - 2021-07-20 17:14:33 [global.GlobalApplicationSettings] - APP_LIB_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\pushmicroservice-17.0.479\common\target\scala-2.12\classes;..\common\target\scala-2.12\classes;C:\PROGRA~1\CA\xFlow\APPS\Services\pushmicroservice-17.0.479\lib\
    INFO - 2021-07-20 17:14:33 [global.GlobalApplicationSettings] - Generating SDM POJOs to location C:\PROGRA~1\CA\xFlow\APPS\\temp\CasmPlayApi\Source\Pojo\
    INFO - 2021-07-20 17:14:33 [com.ca.casm.utils.Utils] - The Service Desk environment is non-tenanted.
    INFO - 2021-07-20 17:14:44 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock acquired: true, is shared: false
    INFO - 2021-07-20 17:15:00 [com.ca.casm.sdm.SdmPojoProvider] - Skipping POJO generation as majic checksums match!
    INFO - 2021-07-20 17:15:03 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock released: true
    INFO - 2021-07-20 17:15:05 [global.GlobalApplicationSettings] - Unit Test ---> PriPOJO Entity Name = pri
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:encryptRoleID
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.audienceuris
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.enableManualRedirect
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.realm
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.reply
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.friendlyname
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.issuer
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.thumbprint
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:Incident_MicroService_akka.cluster.seed-nodes.0
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.context
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.domain
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.hostname
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.insightserver.name
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.requestimeout
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.theme
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.protocol
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:sso.secured.cookies
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - KD Settings: SUBMIT_COMMENTS = 1
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - KD Settings: VIEW_COMMENTS = 1
    INFO - 2021-07-20 17:15:05 [com.ca.casm.utils.Utils] - log4jPropFilePath: C:\PROGRA~1\CA\xFlow\APPS\Services\pushmicroservice-17.0.479\\conf\log4j.properties
    INFO - 2021-07-20 17:15:05 [com.ca.casm.utils.Utils] - log4jRefreshInterval variable is null or empty. Defaulting the refresh interval to 300 seconds.
    INFO - 2021-07-20 17:15:05 [c.ca.casm.authorization.CacheLoader] - Started loading cache_info from database and ehcache.xml file.
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cache_info
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cache_info
    INFO - 2021-07-20 17:15:05 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from CA SDM):itpam_tasks_info_cache#max#entry:25000
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_auth
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_auth
    INFO - 2021-07-20 17:15:05 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache related to role authorization.
    INFO - 2021-07-20 17:15:05 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for functional access role.
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_access
    INFO - 2021-07-20 17:15:05 [c.ca.casm.authorization.CacheLoader] - Total role objects : 46
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_access
    INFO - 2021-07-20 17:15:05 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:dcon
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - Total func_access_role object count : 1664
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for dcon
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for data partition.
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp_role
    ERROR - 2021-07-20 17:15:06 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$12(CacheLoader.java:762)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - Total data partition record count is 178
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp_role
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type role.
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - Total acctyp_role record count is 119
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type objects.
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:my_context
    ERROR - 2021-07-20 17:15:06 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$16(CacheLoader.java:1106)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for my_context
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: object_customized
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: bui_object_customized
    INFO - 2021-07-20 17:15:06 [c.ca.casm.authorization.Authorizer] - Register for changes initialization started for authorization module cache.
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: role
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: func_access_role
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: dcon
    INFO - 2021-07-20 17:15:06 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tenant
    ERROR - 2021-07-20 17:15:06 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$18(CacheLoader.java:1249)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    ERROR - 2021-07-20 17:15:06 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$loadAccTypeCache$20(CacheLoader.java:1387)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tenant
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tenant
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tgm_members
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tgm_members
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tgm_members
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cnt
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cnt
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: cnt
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp_role
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: user_context
    INFO - 2021-07-20 17:15:07 [c.ca.casm.authorization.Authorizer] - Register for changes finished registration with SDM.
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:master_data_cache
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for master_data_cache
    INFO - 2021-07-20 17:15:07 [c.c.c.a.cache.MasterDataCacheMgr] - Caching for master data factories is disabled.
    INFO - 2021-07-20 17:15:07 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:authentication-cache
    ERROR - 2021-07-20 17:15:07 [c.c.c.a.s.AuthenticationServiceSessionCache] - Invalid value specified for SessionTimeout in configuration
    ERROR - 2021-07-20 17:15:08 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$14(CacheLoader.java:928)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)








    xFlow\APPS\logs\pushservicestderr.txt
    -------------------------------------
    WARNING: An illegal reflective access operation has occurred
    WARNING: Illegal reflective access by com.google.inject.internal.cglib.core.$ReflectUtils$1 (file:/C:/Program%20Files/CA/xFlow/APPS/Services/pushmicroservice-17.0.479/lib/com.google.inject.guice-4.1.0.jar) to method java.lang.ClassLoader.defineClass(java.lang.String,byte[],int,int,java.security.ProtectionDomain)
    WARNING: Please consider reporting this to the maintainers of com.google.inject.internal.cglib.core.$ReflectUtils$1
    WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
    WARNING: All illegal access operations will be denied in a future release
    log4j:ERROR setFile(null,true) call failed.
    java.io.FileNotFoundException: =C:\PROGRA~1\CA\xFlow\APPS\logs\pushMS_slump.log (Die Syntax für den Dateinamen, Verzeichnisnamen oder die Datenträgerbezeichnung ist falsch)
    at java.base/java.io.FileOutputStream.open0(Native Method)
    at java.base/java.io.FileOutputStream.open(FileOutputStream.java:298)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:237)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:158)
    at org.apache.log4j.FileAppender.setFile(FileAppender.java:290)
    at org.apache.log4j.RollingFileAppender.setFile(RollingFileAppender.java:194)
    at org.apache.log4j.FileAppender.activateOptions(FileAppender.java:164)
    at org.apache.log4j.config.PropertySetter.activate(PropertySetter.java:257)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:133)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:97)
    at org.apache.log4j.PropertyConfigurator.parseAppender(PropertyConfigurator.java:689)
    at org.apache.log4j.PropertyConfigurator.parseCategory(PropertyConfigurator.java:647)
    at org.apache.log4j.PropertyConfigurator.configureRootCategory(PropertyConfigurator.java:544)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:440)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:476)
    at org.apache.log4j.helpers.OptionConverter.selectAndConfigure(OptionConverter.java:471)
    at org.apache.log4j.LogManager.<clinit>(LogManager.java:125)
    at java.base/java.lang.Class.forName0(Native Method)
    at java.base/java.lang.Class.forName(Class.java:398)
    at org.jboss.logging.LoggerProviders.tryLog4j(LoggerProviders.java:134)
    at org.jboss.logging.LoggerProviders.findProvider(LoggerProviders.java:96)
    at org.jboss.logging.LoggerProviders.find(LoggerProviders.java:34)
    at org.jboss.logging.LoggerProviders.<clinit>(LoggerProviders.java:31)
    at org.jboss.logging.Logger.getLogger(Logger.java:2465)
    at org.jboss.logging.Logger$1.run(Logger.java:2565)
    at java.base/java.security.AccessController.doPrivileged(Native Method)
    at org.jboss.logging.Logger.getMessageLogger(Logger.java:2529)
    at org.jboss.logging.Logger.getMessageLogger(Logger.java:2516)
    at org.hibernate.validator.internal.util.logging.LoggerFactory.make(LoggerFactory.java:19)
    at org.hibernate.validator.internal.util.Version.<clinit>(Version.java:22)
    at org.hibernate.validator.internal.engine.ConfigurationImpl.<clinit>(ConfigurationImpl.java:71)
    at org.hibernate.validator.HibernateValidator.createGenericConfiguration(HibernateValidator.java:33)
    at javax.validation.Validation$GenericBootstrapImpl.configure(Validation.java:276)
    at play.data.validation.ValidatorProvider.<init>(ValidatorProvider.java:27)
    at play.data.validation.ValidatorProvider$$FastClassByGuice$$580fd498.newInstance(<generated>)
    at com.google.inject.internal.DefaultConstructionProxyFactory$FastClassProxy.newInstance(DefaultConstructionProxyFactory.java:89)
    at com.google.inject.internal.ConstructorInjector.provision(ConstructorInjector.java:111)
    at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:90)
    at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:268)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.BoundProviderFactory.get(BoundProviderFactory.java:61)
    at com.google.inject.internal.SingleParameterInjector.inject(SingleParameterInjector.java:38)
    at com.google.inject.internal.SingleParameterInjector.getAll(SingleParameterInjector.java:62)
    at com.google.inject.internal.ConstructorInjector.provision(ConstructorInjector.java:110)
    at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:90)
    at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:268)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:205)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1085)
    at com.google.inject.internal.InternalInjectorCreator.loadEagerSingletons(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:180)
    at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:110)
    at com.google.inject.Guice.createInjector(Guice.java:99)
    at com.google.inject.Guice.createInjector(Guice.java:84)
    at play.api.inject.guice.GuiceBuilder.injector(GuiceInjectorBuilder.scala:185)
    at play.api.inject.guice.GuiceApplicationBuilder.build(GuiceApplicationBuilder.scala:137)
    at play.api.inject.guice.GuiceApplicationLoader.load(GuiceApplicationLoader.scala:21)
    at play.core.server.ProdServerStart$.start(ProdServerStart.scala:51)
    at play.core.server.ProdServerStart$.main(ProdServerStart.scala:25)
    at play.core.server.ProdServerStart.main(ProdServerStart.scala)
    log4j:ERROR setFile(null,true) call failed.
    java.io.FileNotFoundException: =C:\PROGRA~1\CA\xFlow\APPS\logs\pushMS_slump.log (Die Syntax für den Dateinamen, Verzeichnisnamen oder die Datenträgerbezeichnung ist falsch)
    at java.base/java.io.FileOutputStream.open0(Native Method)
    at java.base/java.io.FileOutputStream.open(FileOutputStream.java:298)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:237)
    at java.base/java.io.FileOutputStream.<init>(FileOutputStream.java:158)
    at org.apache.log4j.FileAppender.setFile(FileAppender.java:290)
    at org.apache.log4j.RollingFileAppender.setFile(RollingFileAppender.java:194)
    at org.apache.log4j.FileAppender.activateOptions(FileAppender.java:164)
    at org.apache.log4j.config.PropertySetter.activate(PropertySetter.java:257)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:133)
    at org.apache.log4j.config.PropertySetter.setProperties(PropertySetter.java:97)
    at org.apache.log4j.PropertyConfigurator.parseAppender(PropertyConfigurator.java:689)
    at org.apache.log4j.PropertyConfigurator.parseCategory(PropertyConfigurator.java:647)
    at org.apache.log4j.PropertyConfigurator.configureRootCategory(PropertyConfigurator.java:544)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:440)
    at org.apache.log4j.PropertyConfigurator.doConfigure(PropertyConfigurator.java:334)






    xFlow\APPS\logs\pushservicestdout.txt
    -------------------------------------
    17:14:14,019 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
    17:14:14,019 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
    17:14:14,019 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/Program%20Files/CA/xFlow/APPS/Services/pushmicroservice-17.0.479/conf/logback.xml]
    17:14:14,331 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
    17:14:14,347 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/C:/Program%20Files/CA/xFlow/APPS/Services/pushmicroservice-17.0.479/conf/logback.xml]
    17:14:14,347 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 minutes
    17:14:14,363 |-INFO in ch.qos.logback.core.joran.action.ConversionRuleAction - registering conversion word coloredLevel with class [play.api.libs.logback.ColoredLevel]
    17:14:14,363 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
    17:14:14,363 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
    17:14:14,378 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@24:79 - no applicable action for [rollingPolicy], current ElementPath is [[configuration][appender][rollingPolicy]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@26:26 - no applicable action for [fileNamePattern], current ElementPath is [[configuration][appender][rollingPolicy][fileNamePattern]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@27:107 - no applicable action for [timeBasedFileNamingAndTriggeringPolicy], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@28:26 - no applicable action for [maxFileSize], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy][maxFileSize]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@31:21 - no applicable action for [maxHistory], current ElementPath is [[configuration][appender][rollingPolicy][maxHistory]]
    17:14:14,441 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/pushMS.log]
    17:14:14,456 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
    17:14:14,456 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [ASYNCFILE]
    17:14:14,456 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [FILE] to ch.qos.logback.classic.AsyncAppender[ASYNCFILE]
    17:14:14,456 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Attaching appender named [FILE] to AsyncAppender.
    17:14:14,456 |-INFO in ch.qos.logback.classic.AsyncAppender[ASYNCFILE] - Setting discardingThreshold to 51
    17:14:14,456 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
    17:14:14,456 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DEBUGFILE]
    17:14:14,456 |-INFO in ch.qos.logback.core.rolling.FixedWindowRollingPolicy@7b139eab - No compression will be used
    17:14:14,472 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - Active log file name: C:\PROGRA~1\CA\xFlow\APPS\\logs/pushMS_debug.log
    17:14:14,472 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[DEBUGFILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/pushMS_debug.log]
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [play] to INFO
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [application] to INFO
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebean.config.PropertyMapLoader] to OFF
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.core.XmlConfigLoader] to OFF
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.avaje.ebeaninternal.server.lib.BackgroundThread] to OFF
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.gargoylesoftware.htmlunit.javascript] to OFF
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
    17:14:14,472 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [ASYNCFILE] to Logger[ROOT]
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
    17:14:14,472 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@4e76dac - Registering current configuration as safe fallback point

    17:14:14,019 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
    17:14:14,019 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
    17:14:14,019 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/Program%20Files/CA/xFlow/APPS/Services/pushmicroservice-17.0.479/conf/logback.xml]
    17:14:14,331 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
    17:14:14,347 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/C:/Program%20Files/CA/xFlow/APPS/Services/pushmicroservice-17.0.479/conf/logback.xml]
    17:14:14,347 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 5 minutes
    17:14:14,363 |-INFO in ch.qos.logback.core.joran.action.ConversionRuleAction - registering conversion word coloredLevel with class [play.api.libs.logback.ColoredLevel]
    17:14:14,363 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.FileAppender]
    17:14:14,363 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [FILE]
    17:14:14,378 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@24:79 - no applicable action for [rollingPolicy], current ElementPath is [[configuration][appender][rollingPolicy]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@26:26 - no applicable action for [fileNamePattern], current ElementPath is [[configuration][appender][rollingPolicy][fileNamePattern]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@27:107 - no applicable action for [timeBasedFileNamingAndTriggeringPolicy], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@28:26 - no applicable action for [maxFileSize], current ElementPath is [[configuration][appender][rollingPolicy][timeBasedFileNamingAndTriggeringPolicy][maxFileSize]]
    17:14:14,441 |-ERROR in ch.qos.logback.core.joran.spi.Interpreter@31:21 - no applicable action for [maxHistory], current ElementPath is [[configuration][appender][rollingPolicy][maxHistory]]
    17:14:14,441 |-INFO in ch.qos.logback.core.FileAppender[FILE] - File property is set to [C:\PROGRA~1\CA\xFlow\APPS\\logs/pushMS.log]
    17:14:14,456 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]






    xFlow\APPS\logs\searchMS.log
    -------------------------------------
    INFO - 2021-07-20 17:14:23 [akka.event.slf4j.Slf4jLogger] - Slf4jLogger started
    INFO - 2021-07-20 17:14:28 [application] - Connecting to Slump
    INFO - 2021-07-20 17:14:32 [global.GlobalApplicationSettings] - APP_CODE: 1
    INFO - 2021-07-20 17:14:32 [global.GlobalApplicationSettings] - APP_NAME: Search MicroService
    INFO - 2021-07-20 17:14:32 [global.GlobalApplicationSettings] - APP_ROOT_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\searchmicroservice-17.0.479\
    INFO - 2021-07-20 17:14:32 [global.GlobalApplicationSettings] - APP_LIB_DIR: C:\PROGRA~1\CA\xFlow\APPS\Services\searchmicroservice-17.0.479\common\target\scala-2.12\classes;..\common\target\scala-2.12\classes;C:\PROGRA~1\CA\xFlow\APPS\Services\searchmicroservice-17.0.479\lib\
    INFO - 2021-07-20 17:14:32 [com.ca.casm.utils.Utils] - The Service Desk environment is non-tenanted.
    INFO - 2021-07-20 17:14:35 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock acquired: true, is shared: false
    INFO - 2021-07-20 17:14:44 [com.ca.casm.sdm.SdmPojoProvider] - Skipping POJO generation as majic checksums match!
    INFO - 2021-07-20 17:14:55 [com.ca.casm.sdm.SdmPojoProvider] - POJO file lock released: true
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:encryptRoleID
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.audienceuris
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.enableManualRedirect
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.realm
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.reply
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.friendlyname
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.issuer
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:federation.trustedissuers.thumbprint
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:Incident_MicroService_akka.cluster.seed-nodes.0
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.context
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.domain
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.hostname
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.insightserver.name
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.requestimeout
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.jasper.theme
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:insights.protocol
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - Property loaded from DB:sso.secured.cookies
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - KD Settings: SUBMIT_COMMENTS = 1
    INFO - 2021-07-20 17:14:56 [com.ca.casm.actor.global.ActorUtils] - KD Settings: VIEW_COMMENTS = 1
    INFO - 2021-07-20 17:14:56 [com.ca.casm.utils.Utils] - log4jPropFilePath: C:\PROGRA~1\CA\xFlow\APPS\Services\searchmicroservice-17.0.479\\conf\log4j.properties
    INFO - 2021-07-20 17:14:56 [com.ca.casm.utils.Utils] - log4jRefreshInterval variable is null or empty. Defaulting the refresh interval to 300 seconds.
    INFO - 2021-07-20 17:14:56 [c.ca.casm.authorization.CacheLoader] - Started loading cache_info from database and ehcache.xml file.
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cache_info
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cache_info
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from CA SDM):itpam_tasks_info_cache#max#entry:25000
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - Max entry key-value(from xml):my_context#max#entry:1
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_auth
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_auth
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache related to role authorization.
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for functional access role.
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:role_access
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - Total role objects : 46
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for role_access
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:dcon
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - Total func_access_role object count : 1664
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for dcon
    ERROR - 2021-07-20 17:14:57 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$12(CacheLoader.java:762)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for data partition.
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp_role
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - Total data partition record count is 178
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp_role
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type role.
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:acctyp
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - Total acctyp_role record count is 119
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for acctyp
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for access type objects.
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.CacheLoader] - >>> Started loading cache for my context object.
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: object_customized
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: bui_object_customized
    INFO - 2021-07-20 17:14:57 [c.ca.casm.authorization.Authorizer] - Register for changes initialization started for authorization module cache.
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: role
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: func_access_role
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: dcon
    INFO - 2021-07-20 17:14:57 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tenant
    ERROR - 2021-07-20 17:14:58 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$16(CacheLoader.java:1106)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tenant
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tenant
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:tgm_members
    ERROR - 2021-07-20 17:14:58 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$null$18(CacheLoader.java:1249)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    ERROR - 2021-07-20 17:14:58 [c.ca.casm.framework.util.CasmFuture] - Exception occurred, see call stack for more details: userid ()
    java.util.concurrent.CompletionException: java.lang.NullPointerException
    at java.base/java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:331)
    at java.base/java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:346)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:870)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    at java.base/java.util.concurrent.CompletableFuture.postComplete(CompletableFuture.java:506)
    Caused by: java.lang.NullPointerException: null
    at com.ca.casm.authorization.CacheLoader.lambda$loadAccTypeCache$20(CacheLoader.java:1387)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:72)
    at java.base/java.util.function.BiConsumer.lambda$andThen$0(BiConsumer.java:71)
    at java.base/java.util.concurrent.CompletableFuture.uniWhenComplete(CompletableFuture.java:859)
    at java.base/java.util.concurrent.CompletableFuture$UniWhenComplete.tryFire(CompletableFuture.java:837)
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for tgm_members
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: tgm_members
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:cnt
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for cnt
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: cnt
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: acctyp_role
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.cache.ListenerMgr] - Registering for changes for factory: user_context
    INFO - 2021-07-20 17:14:58 [c.ca.casm.authorization.Authorizer] - Register for changes finished registration with SDM.
    INFO - 2021-07-20 17:14:58 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:master_data_cache
    INFO - 2021-07-20 17:14:59 [com.ca.casm.actor.global.ActorUtils] - No cache definition found in SDM, returning default conf for master_data_cache
    INFO - 2021-07-20 17:14:59 [c.c.c.a.cache.MasterDataCacheMgr] - Caching for master data factories is disabled.
    INFO - 2021-07-20 17:14:59 [com.ca.casm.actor.global.ActorUtils] - Cache configuration NOT defined in xml for the cache name:authentication-cache
    ERROR - 2021-07-20 17:14:59 [c.c.c.a.s.AuthenticationServiceSessionCache] - Invalid value specified for SessionTimeout in configuration




    ----------------------------------------------------------------------------------------------------------------------------------------------------------------




    When I execute the batch file to start the incident Microservices from xFlow\APPS\Serivces\incidentmicroservice-17.0.479\bin\incidentmicroservice.bat
    Then I get additional echo information in CMD:


    Die Datei "C:\Program Files\CA\xFlow\APPS\Services\incidentmicroservice-17.0.479\bin\\\..\INCIDENTMICROSERVICE_config.txt" kann nicht gefunden werden.
    WARNING: An illegal reflective access operation has occurred
    WARNING: Illegal reflective access by com.google.inject.internal.cglib.core.$ReflectUtils$1 (file:/C:/Program%20Files/CA/xFlow/APPS/Services/incidentmicroservice-17.0.479/lib/com.google.inject.guice-4.1.0.jar) to method java.lang.ClassLoader.defineClass(java.lang.String,byte[],int,int,java.security.ProtectionDomain)
    WARNING: Please consider reporting this to the maintainers of com.google.inject.internal.cglib.core.$ReflectUtils$1
    WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations
    WARNING: All illegal access operations will be denied in a future release
    Oops, cannot start the server.
    com.google.inject.CreationException: Unable to create injector, see the following errors:

    1) Error injecting constructor, java.lang.ExceptionInInitializerError
    at global.GlobalApplicationSettings.<init>(GlobalApplicationSettings.java:97)
    at modules.IncidentMSModule.configure(IncidentMSModule.java:42) (via modules: com.google.inject.util.Modules$OverrideModule -> modules.IncidentMSModule)
    while locating global.GlobalApplicationSettings

    1 error
    at com.google.inject.internal.Errors.throwCreationExceptionIfErrorsExist(Errors.java:470)
    at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:184)
    at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:110)
    at com.google.inject.Guice.createInjector(Guice.java:99)
    at com.google.inject.Guice.createInjector(Guice.java:84)
    at play.api.inject.guice.GuiceBuilder.injector(GuiceInjectorBuilder.scala:185)
    at play.api.inject.guice.GuiceApplicationBuilder.build(GuiceApplicationBuilder.scala:137)
    at play.api.inject.guice.GuiceApplicationLoader.load(GuiceApplicationLoader.scala:21)
    at play.core.server.ProdServerStart$.start(ProdServerStart.scala:51)
    at play.core.server.ProdServerStart$.main(ProdServerStart.scala:25)
    at play.core.server.ProdServerStart.main(ProdServerStart.scala)
    Caused by: java.lang.ExceptionInInitializerError
    at global.GlobalApplicationSettings.<init>(GlobalApplicationSettings.java:193)
    at global.GlobalApplicationSettings$$FastClassByGuice$$66c47645.newInstance(<generated>)
    at com.google.inject.internal.DefaultConstructionProxyFactory$FastClassProxy.newInstance(DefaultConstructionProxyFactory.java:89)
    at com.google.inject.internal.ConstructorInjector.provision(ConstructorInjector.java:111)
    at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:90)
    at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:268)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1092)
    at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
    at com.google.inject.internal.SingletonScope$1.get(SingletonScope.java:194)
    at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:41)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:205)
    at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1085)
    at com.google.inject.internal.InternalInjectorCreator.loadEagerSingletons(InternalInjectorCreator.java:199)
    at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:180)
    ... 9 more
    Caused by: net.sf.ehcache.config.InvalidConfigurationException: There is one error in your configuration:
    * Cache 'authentication-cache' error: If your CacheManager has no maxBytesLocalHeap set, you need to either set maxEntriesLocalHeap or maxBytesLocalHeap at the Cache level


    at net.sf.ehcache.config.CacheConfiguration.setupFor(CacheConfiguration.java:1704)
    at net.sf.ehcache.config.CacheConfiguration.setupFor(CacheConfiguration.java:1688)
    at net.sf.ehcache.CacheManager.initializeEhcache(CacheManager.java:1352)
    at net.sf.ehcache.CacheManager.addCacheNoCheck(CacheManager.java:1423)
    at net.sf.ehcache.CacheManager.addCache(CacheManager.java:1299)
    at net.sf.ehcache.CacheManager.addCache(CacheManager.java:1268)
    at com.ca.casm.authentication.session.AuthenticationServiceSessionCache.<init>(AuthenticationServiceSessionCache.java:89)
    at com.ca.casm.authentication.session.AuthenticationServiceSessionCache.<clinit>(AuthenticationServiceSessionCache.java:61)
    ... 25 more






    ----------------------------------------------------------------------------------------------------------------------------------------------------------------

    What can cause the xFlow service to be unreachable?
    Maybe a wrong environment variable setup for Java?

    Currently:
    JAVA_HOME: C:\Program Files\CA\SC\JRE\11.0.3
    Path: %JAVA_HOME%\bin;....
    -->
    java -version:
    openjdk version "11.0.3" 2019-04-16
    OpenJDK Runtime Environment AdoptOpnenJDK (build 11.0.3+7)
    OpenJDK 64-Bit Server VM AdoptOpenJDK (build 11.0.3+7, mixed mode)


    Any help would be appreciated.

    Regards
    Christoph

    ------------------------------
    ...
    ------------------------------


  • 2.  RE: xFlow login page not reachable

    Broadcom Employee
    Posted Jul 29, 2021 09:51 AM
    Perhaps log a case with support for further investigation?

    ------------------------------
    Kind Regards,
    Brian
    ------------------------------



  • 3.  RE: xFlow login page not reachable

    Broadcom Employee
    Posted Jul 29, 2021 09:52 AM
    Perhaps log a case with Support for further investigation?

    ------------------------------
    Kind Regards,
    Brian
    ------------------------------



  • 4.  RE: xFlow login page not reachable

    Broadcom Employee
    Posted Jul 29, 2021 09:52 AM
    If you have not already done so, would recommend opening a Broadcom Support case for further investigation

    ------------------------------
    Paul Coccimiglio
    Principal Support Engineer
    Broadcom Inc.
    ------------------------------



  • 5.  RE: xFlow login page not reachable

    Broadcom Employee
    Posted Jul 31, 2021 06:55 AM
    you could use the browser console and see what kind of error message you receive on the browser side. this usually gives you some hint what happened.
    if this does not go anywhere, maybe it is time to open a case with Support.


  • 6.  RE: xFlow login page not reachable

    Broadcom Employee
    Posted Jul 31, 2021 06:55 AM
    you may want to use browser console and see what error messages you receive and that usually gives some hint of the problem.
    and yes maybe a new support case is not a bad idea.