2023-05-03/04:20:30.246 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Validating tasks for Securitysystem - Test Datorama 2023-05-03/04:20:30.251 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - new account , accountName = vishnu.pt@contracted.sampoerna.com , taskType = 3 2023-05-03/04:20:30.279 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Calling rest createAccount with Sec System - Test Datorama and tasklist - [vishnu.pt@contracted.sampoerna.com:[com.saviynt.ecm.task.ArsTasks : 1302205]] 2023-05-03/04:20:30.280 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - Entering RestProvisioningService : createAccount 2023-05-03/04:20:30.281 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - initializing Provisioning connection 2023-05-03/04:20:30.282 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - extAttList - [com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6919, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6920, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6921, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6922, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6923, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6924, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6925, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6926, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6927, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6928, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6929, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6930, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6931, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6932, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6933, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6934, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6935, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6936, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6937, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6938, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6939, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6940, com.saviynt.ecm.utility.domain.ExternalconnectionAttributeValue : 6941] 2023-05-03/04:20:30.300 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - createAccountJSON: [accountIdPath:call1.message.email, dateFormat:yyyy-MM-dd'T'HH:mm:ssXXX, responseColsToPropsMap:[name:call1.message.email~#~char], call:[[name:call1, connection:userAuth, url:https://app-eu.datorama.com/v1/users, httpMethod:POST, httpParams:{"email":"vishnu.pt@contracted.sampoerna.com","name":"","accountId":"1110602","firstName":"Vishnu","lastName":"PT","role":"ACCOUNT_VIEWER","uiTheme":"BLACK_THEME","active":"true"}, httpHeaders:[content-Type:application/json, Accept:application/json, Authorization:dato-api-8609b822-472e-49c0-bde5-79c2ab44378f], httpContentType:application/json, successResponses:[statusCode:[200, 201]]]]] 2023-05-03/04:20:30.306 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - configJSON: [showLogs:true] 2023-05-03/04:20:30.315 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - email: vishnu.pt@contracted.sampoerna.com 2023-05-03/04:20:30.315 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - Calling createNewUser 2023-05-03/04:20:30.315 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - arsTasks.provisioningComments null 2023-05-03/04:20:30.316 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - arsTasks?.requestAccessKey: com.saviynt.ecm.workflow.Request_Access : 56191 2023-05-03/04:20:30.384 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Enter useDefaultAttrValInRequest 2023-05-03/04:20:30.385 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - USE_DEFAULT_ATTR_VALS_IN_REQUEST = 2023-05-03/04:20:30.385 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - usedefaultval = false 2023-05-03/04:20:30.385 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Exit useDefaultAttrValInRequest 2023-05-03/04:20:30.385 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - Validating Password Policy and setting defaults... 2023-05-03/04:20:30.388 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - Total Call: 1 2023-05-03/04:20:30.457 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - connection: userAuth 2023-05-03/04:20:30.482 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestUtilService - Calling https://app-eu.datorama.com//v1/users 2023-05-03/04:20:30.484 [{}] [quartzScheduler_Worker-7] DEBUG services.HttpClientUtilityService - isFipsEnabled = false 2023-05-03/04:20:30.484 [{}] [quartzScheduler_Worker-7] DEBUG services.HttpClientUtilityService - getHttpClient - sslParams : null 2023-05-03/04:20:30.484 [{}] [quartzScheduler_Worker-7] DEBUG services.HttpClientUtilityService - getHttpClient - proxyParams : null 2023-05-03/04:20:30.484 [{}] [quartzScheduler_Worker-7] DEBUG services.HttpClientUtilityService - getHttpClient - sslSocketFactory : null 2023-05-03/04:20:30.490 [{}] [quartzScheduler_Worker-7] DEBUG services.HttpClientUtilityService - getHttpClient - HttpClientBuilder.create().build() called. 2023-05-03/04:20:30.589 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - ecmjobIdQuery .. select max(eij.JOBID) as 'JobId' from EcmImportJob eij where eij.TRIGGERNAME in (select qrt.TRIGGER_NAME from qrtz_triggers qrt) group by eij.TRIGGERNAME 2023-05-03/04:20:30.808 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestUtilService - fetching result from response.responseText 2023-05-03/04:20:30.810 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestUtilService - connectionid:: null 2023-05-03/04:20:30.821 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - access token populated for oauth authentication.. 2023-05-03/04:20:30.836 [{}] [quartzScheduler_Worker-7] ERROR rest.RestProvisioningService - Access Token is null.. 2023-05-03/04:20:30.849 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - response: [:] 2023-05-03/04:20:30.849 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - Response size: 0 2023-05-03/04:20:30.849 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - Task Response: null 2023-05-03/04:20:30.849 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - accountId: null 2023-05-03/04:20:30.849 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - Task Response: null 2023-05-03/04:20:30.857 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - accountResponseMap: [:] 2023-05-03/04:20:30.857 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - taskResult: true 2023-05-03/04:20:30.857 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - isEntitlementOnly: false 2023-05-03/04:20:30.857 [{}] [quartzScheduler_Worker-7] DEBUG rest.RestProvisioningService - taskResult:: true 2023-05-03/04:20:30.858 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Inside updateProvisioningTries.. 2023-05-03/04:20:30.873 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Entering provisionAccesstoAccountSaviynt 2023-05-03/04:20:30.873 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - {vishnu.pt@contracted.sampoerna.com=[com.saviynt.ecm.task.ArsTasks : 1302205]} 2023-05-03/04:20:30.873 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - NewAccount 2023-05-03/04:20:30.885 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Processing task 1302205 start 2023-05-03/04:20:30.891 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - completing task = 1302205 2023-05-03/04:20:30.891 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - completing task = 1302205 done 2023-05-03/04:20:30.912 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Account is null creating one 2023-05-03/04:20:30.922 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - null 2023-05-03/04:20:30.936 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - reqAccAttrsEndpointDetail -[com.saviynt.ecm.workflow.Request_access_attrs : 90355] 2023-05-03/04:20:30.937 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - reqAccAttrs -[com.saviynt.ecm.workflow.Request_access_attrs : 90354, com.saviynt.ecm.workflow.Request_access_attrs : 90355] 2023-05-03/04:20:30.942 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Saving Acc-vishnu.pt@contracted.sampoerna.com Accountid-vishnu.pt@contracted.sampoerna.com Endpoint-Test Datorama, SystemID=434 2023-05-03/04:20:30.972 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - saved account object[vishnu.pt@contracted.sampoerna.com Accountid-vishnu.pt@contracted.sampoerna.com Endpoint-Test Datorama, SystemID=434 2023-05-03/04:20:30.982 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - adding entry into user account.. userkey = 961353 , accountkey = 17580887 2023-05-03/04:20:30.997 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - existingOrNew= NewAccount, accounts= vishnu.pt@contracted.sampoerna.com, task= com.saviynt.ecm.task.ArsTasks : 1302205, parenttask= null 2023-05-03/04:20:30.997 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - processing accountkey 17580887 for task 1302205 2023-05-03/04:20:31.005 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - assignedFromRoles : null 2023-05-03/04:20:31.006 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Enter saveSodriskAndAssociations ........... 2023-05-03/04:20:31.012 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Exit saveSodriskAndAssociations........... 2023-05-03/04:20:31.012 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Processing task 1302205 done 2023-05-03/04:20:31.015 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Final status of task 1302205 - 3 2023-05-03/04:20:31.017 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Config for ARSTASKCOMPNEWPWDcom.saviynt.ecm.utility.domain.EcmConfig : ARSTASKCOMPNEWPWD 2023-05-03/04:20:31.019 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Task Complete Email Template For New Account Password = TestEmailTemplete 2023-05-03/04:20:31.019 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - start converting accTasksMap to endpointaccTasksMap 2023-05-03/04:20:31.028 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - finished converting accTasksMap to endpointaccTasksMap 2023-05-03/04:20:31.039 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Start bindBaseUrlEmailTemplate 2023-05-03/04:20:31.039 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - baseUrlForEmail value in externalConfig : [:] 2023-05-03/04:20:31.039 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - baseUrlForEmail is missing in the externalConfig file. Please add it ! 2023-05-03/04:20:31.045 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - emailTemplates for template type = 1 [:] 2023-05-03/04:20:31.045 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - type: 3 2023-05-03/04:20:31.045 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - taskEmailTemplatesList size: 0 2023-05-03/04:20:31.046 [{}] [quartzScheduler_Worker-7] DEBUG saviynt.AccountsService - Inside isServiceAccount 2023-05-03/04:20:31.047 [{}] [quartzScheduler_Worker-7] DEBUG saviynt.AccountsService - isServiceAccount: false 2023-05-03/04:20:31.064 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - In whenTaskTypeIsTwo 2023-05-03/04:20:31.064 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query Remove Access Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 2 and rr.entitlement_valueKey != null and rr.id in (1302205 ) 2023-05-03/04:20:31.083 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query Remove Account Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 2 and rr.entitlement_valueKey is null and rr.id in (1302205 ) 2023-05-03/04:20:31.101 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - In whenTaskTypeIsFiveChangePassword 2023-05-03/04:20:31.101 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query Change Password Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 5 and rr.entitlement_valueKey is null and rr.id in (1302205 ) 2023-05-03/04:20:31.108 [{}] [quartzScheduler_Worker-7] DEBUG utility.P_ManagementService - enter executeP_History 2023-05-03/04:20:31.108 [{}] [quartzScheduler_Worker-7] DEBUG utility.P_ManagementService - taskList: [] 2023-05-03/04:20:31.113 [{}] [quartzScheduler_Worker-7] DEBUG utility.P_ManagementService - exit executeP_History 2023-05-03/04:20:31.136 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - In whenTaskTypeIsSixEnableAccount 2023-05-03/04:20:31.136 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query for Enable Account Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 6 and rr.id in (1302205 ) 2023-05-03/04:20:31.152 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - In whenTaskTypeIsFourteenDisableAccount 2023-05-03/04:20:31.152 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query Disable Account Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 14 and rr.id in (1302205 ) 2023-05-03/04:20:31.168 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - In whenTaskTypeIsEightDeleteAccount 2023-05-03/04:20:31.168 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query Delete Account Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 8 and rr.entitlement_valueKey is null and rr.id in (1302205) 2023-05-03/04:20:31.187 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query for Create New Entitlement Tasks= select rr from ArsTasks rr where rr.accountKey is null and (rr.endDate = null or rr.endDate > :ed) and rr.tasktype = 24 and rr.id in (1302205) 2023-05-03/04:20:31.194 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Found List of Tasks[] 2023-05-03/04:20:31.212 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query for Update Entitlement Tasks= select rr from ArsTasks rr where rr.accountKey is null and (rr.endDate = null or rr.endDate > :ed) and rr.tasktype = 27 and rr.id in (1302205) 2023-05-03/04:20:31.220 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Found List of Tasks[] 2023-05-03/04:20:31.228 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query for Delete Entitlement Tasks= select rr from ArsTasks rr where rr.accountKey is null and (rr.endDate = null or rr.endDate > :ed) and rr.tasktype = 28 and rr.id in (1302205) 2023-05-03/04:20:31.235 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Found List of Tasks[] 2023-05-03/04:20:31.243 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query for Map Entitlement with Entitlement Tasks= select rr from ArsTasks rr where rr.accountKey is null and (rr.endDate = null or rr.endDate > :ed) and rr.tasktype = 25 and rr.id in (1302205) 2023-05-03/04:20:31.250 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Found List of Tasks[] 2023-05-03/04:20:31.258 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query for remove mapping Entitlement with Entitlement Tasks= select rr from ArsTasks rr where rr.accountKey is null and (rr.endDate = null or rr.endDate > :ed) and rr.tasktype = 26 and rr.id in (1302205) 2023-05-03/04:20:31.265 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Found List of Tasks[] 2023-05-03/04:20:31.273 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - start provisionFFIDAccess TaskType-29 2023-05-03/04:20:31.273 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - automatedprovisionqry = rr.securitysystem.automatedProvisioning = true and 2023-05-03/04:20:31.273 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query to fetch FFID grant access tasks = select rr from ArsTasks rr where rr.securitysystem.automatedProvisioning = true and rr.accountKey != null and rr.tasktype = 29 and rr.entitlement_valueKey is null and rr.id in (1302205 ) 2023-05-03/04:20:31.294 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - End provisionFFIDAccess TaskType-27 2023-05-03/04:20:31.294 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Start deprovisionFFIDAccess TaskType-30 2023-05-03/04:20:31.295 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - automatedprovisionqry = rr.securitysystem.automatedProvisioning = true and 2023-05-03/04:20:31.295 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query FFID Revoke Tasks= select rr from ArsTasks rr where rr.securitysystem.automatedProvisioning = true and rr.accountKey != null and rr.tasktype = 30 and rr.entitlement_valueKey is null and rr.id in (1302205 ) 2023-05-03/04:20:31.314 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - End deprovisionFFIDAccess TaskType-28 2023-05-03/04:20:31.315 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Start extendAccessTask TaskType-31 2023-05-03/04:20:31.315 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - automatedprovisionqry = rr.securitysystem.automatedProvisioning = true and 2023-05-03/04:20:31.315 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Query Update Access End Date Tasks= select rr from ArsTasks rr where rr.securitysystem.automatedProvisioning = true and rr.accountKey != null and rr.tasktype = 31 and rr.entitlement_valueKey != null and rr.id in (1302205 ) 2023-05-03/04:20:31.322 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - Total Tasks for Update Access End Date: 0 2023-05-03/04:20:31.334 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskService - End extendAccessTask TaskType-31 2023-05-03/04:20:31.334 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - In lockOrUnlockAccount 2023-05-03/04:20:31.334 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query for Lock Account Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 32 and rr.id in (1302205) 2023-05-03/04:20:31.350 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - In lockOrUnlockAccount 2023-05-03/04:20:31.350 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query for Unlock Account Tasks= select rr from ArsTasks rr where rr.accountKey != null and rr.tasktype = 33 and rr.id in (1302205) 2023-05-03/04:20:31.365 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - cleaning gorm. 2023-05-03/04:20:31.368 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - total records processed = 1 2023-05-03/04:20:31.381 [{}] [quartzScheduler_Worker-7] DEBUG services.ImportUtilityService - Writing job history to import logs for jobID: 1947732 2023-05-03/04:20:31.381 [{}] [quartzScheduler_Worker-7] DEBUG services.ImportUtilityService - Number of log entries to be written : 49 2023-05-03/04:20:31.389 [{}] [quartzScheduler_Worker-7] DEBUG integration.ExternalConnectionCallService - Enter consolidateConcurrentChildTriggerLogs 2023-05-03/04:20:31.389 [{}] [quartzScheduler_Worker-7] DEBUG integration.ExternalConnectionCallService - parentJobId 1947731 2023-05-03/04:20:31.389 [{}] [quartzScheduler_Worker-7] DEBUG services.ImportUtilityService - randomNo: 826 2023-05-03/04:20:32.121 [{}] [https-jsse-nio-443-exec-22] INFO domain.JobcontrolController - Auditing for list of JobControl 2023-05-03/04:20:32.122 [{}] [https-jsse-nio-443-exec-22] INFO domain.JobcontrolController - Auditing process completed for JobControl 2023-05-03/04:20:32.526 [{}] [https-jsse-nio-443-exec-22] DEBUG domain.JobcontrolController - qry = SELECT il.IMPORTLOGID as IMPORTLOGID,il.logDataAsXML as logDataAsXML,ecmimp.jobid as jobID,ecmimp.jobname as JOBNAME,ecmimp.jobStartDate as JOBSTARTDATE,ecmimp.coments as COMMENTS,ecmimp.jobEndDate as JOBENDDATE,il.filename as FILENAME,ecmimp.SAVRESPONSE as SAVRESPONSE,ecmimp.systemName as SYSTEMNAME,ecmimp.externalconnection as EXTERNALCONNECTION,ecmimp.updateUser as UPDATEUSER,ecmimp.triggername as TRIGGERNAME,ecmimp.jobgroup as JOBGROUP,ecmimp.triggerType as TRIGGERTYPE FROM EcmImportJob ecmimp left join ImportLog il on(ecmimp.jobid=il.jobid) where 1=1 AND (ecmimp.jobname = 'WSBlockingRetryJob' OR ecmimp.jobname ='WSBLOCKINGRETRYJOB' ) AND ecmimp.triggername = 'Datorama_Prov' AND ecmimp.jobgroup = 'utility' ORDER BY ecmimp.jobid DESC limit 0,15 2023-05-03/04:20:32.526 [{}] [https-jsse-nio-443-exec-22] DEBUG domain.JobcontrolController - extraQry = AND (ecmimp.jobname = 'WSBlockingRetryJob' OR ecmimp.jobname ='WSBLOCKINGRETRYJOB' ) AND ecmimp.triggername = 'Datorama_Prov' AND ecmimp.jobgroup = 'utility' 2023-05-03/04:20:32.530 [{}] [https-jsse-nio-443-exec-22] DEBUG domain.JobcontrolController - list size = 15 2023-05-03/04:20:32.885 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - jobIdList size = 711 2023-05-03/04:20:32.906 [{}] [quartzScheduler_Worker-9] DEBUG jobs.WSBlockingRetryJob - jobs invoked.... 2023-05-03/04:20:32.937 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - 2023-05-03/04:20:32.937 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - jobAndTriggerQuery .. select e.SAVRESPONSE, e.JOBENDDATE as prev_fire_time, qt.job_name, qt.job_group, qt.trigger_name,qt.trigger_group,qt.next_fire_time, qct.CRON_EXPRESSION from qrtz_triggers qt left join ecmimportjob e on e.TRIGGERNAME=qt.TRIGGER_NAME left join qrtz_cron_triggers qct on qct.TRIGGER_NAME = qt.TRIGGER_NAME where e.JOBID in(1772972,1935046,1711909,1703140,1554327,1919697,1922381,1761151,1684585,1919289,1204523,1213046,928841,1200420,1381380,1205377,1675709,1947125,1189311,979441,1758246,1727037,1936245,1756060,1946191,1686339,1758223,1727969,1668750,1947185,1770540,1947377,1198661,1756226,1199130,1199578,1756223,1869522,1871990,1888099,1947241,1193784,1199231,1690230,1724029,1392140,1668109,1941197,1941193,1947529,1643088,1643090,1643089,1888485,1204313,635647,512950,512081,1891869,1645748,1910119,670955,1941638,1934867,1710284,1849892,1181172,1682290,1682276,1708555,1671091,1484826,1947363,1749697,1401532,1945340,1945324,1946587,1714509,1674048,1674049,1945323,1947113,1675992,1675894,821,1967,561072,1711366,2217,1308653,723706,2328,689298,3257,1441663,963653,959706,965292,1654138,6162,1315985,1055703,1084630,1122401,14171,1125666,1199867,15224,1652710,18648,1264604,20222,1306472,1451905,1330846,1360531,1364313,1365439,112432,1380488,1726701,1399800,1507328,1507329,1507330,1429564,1433886,1507358,1507359,1467623,1472735,1507360,1485059,1501919,1522262,1544879,1527113,1544870,1563806,1580834,1584583,1608989,1625068,1711368,1640562,1640630,1640807,1642362,1644416,1647783,1654148,1653932,1654206,1654436,1654476,1655532,1664269,1664511,1664907,1758584,1672414,1674381,1676160,1676075,1676415,1682739,1682770,1682880,1682969,1684279,1706150,1710135,1711369,1711367,1723942,1727036,1724442,1726632,1726837,1726883,1727353,1748503,1730836,1734249,1745323,1745529,1755550,1759234,1790881,1796937,1838712,1822882,1829868,29541,1871924,1918733,1940807,1940611,36546,123950,133179,690,153057,153526,288245,224321,224469,233339,701,260811,287791,287441,726,451018,499650,1761587,1761071,513039,1508187,1760203,1710299,1933384,1842125,1672352,1772702,1772716,1606282,1613809,1684471,1653806,1606275,1613802,1684563,1772713,1608715,1613932,1682760,1725534,1654532,1606274,1613800,1684562,1533617,1587892,1606273,1613799,1684561,1947729,1352193,1752380,1752382,1312111,1772704,523875,1922342,1936732,1946172,1936733,1946186,1571756,1875128,1933242,504670,1897014,1745239,1700873,1639422,1745234,1467969,490584,1310707,1925052,1910002,1921306,1175401,1910454,1947731,1120510,1670827,1946144,1772635,1772643,1717663,1654127,153812,1060752,1770504,1772634,1045075,1195000,1579276,1945585,1674744,1873069,500592,1204845,1888307,1187572,876424,1187053,1947086,1668111,1947304,1199513,1737625,1734300,1453824,1791000,1503193,1790878,1749457,1200014,1730275,1749322,1761563,1543252,1896944,1880174,1896942,1682769,1749690,1755831,1918679,1770434,1922306,1877139,1922305,1933449,1228034,1752383,1947730,1668104,1947236,1888260,1869576,1947253,1896519,1942005,1831390,1869535,1947722,1946150,1180484,1947728,1474328,920634,1471272,1945975,1945862,1943267,1630071,1945865,1942444,1945979,1942557,1943271,1936731,1630750,1630771,1654150,1935018,484169,527743,1911233,348581,527744,527979,89335,1263721,1339416,1339418,1339417,1315862,1630401,1716831,1630847,1339870,1946175,1280544,1280546,1280545,1280549,1280555,1280551,500596,565,1947492,1947491,1947490,1527408,1527410,1527409,1752384,1772776,1945605,864274,722369,583338,1726990,1759019,1682744,1837982,1945448,1611415,1946663,1769381,1743485,1946605,1918757,1918762,1513594,1513593,1513595,1726790,1946607,1564353,1946573,1776190,1946574,1627146,1946660,1138945,1339744,1205411,1946656,1924017,1473004,998559,580389,1947716,580518,580582,1072222,758896,580711,580774,1492337,88400,1044861,1761726,1761826,1654254,1326034,1180483,1395261,1701358,1781999,1781978,1758597,1734144,1782119,1946168,645502,1045255,1648045,959850,1656506,1505828,1505832,1505829,1435525,1630735,1630313,1631255,1717635,1630556,1674020,1712021,1726978,1725163,1674013,1725289,1945316,1945443,1945317,1946153,1946154,1454857,1473049,1552418,1397462,1668801,1416212,1352929,1094775,1366413,1704130,54431,1750104,1725405,1750134,1399764,1404528,495329,1630337,580187,527659,1910615,1400764,1755471,1459615,648626,1494614,1306513,1311374,1367253,1315960,1352648,562786,1725498,1725499,1725579,1671376,1772703,1648319,1639721,1724555,1640639,1772708,1709331,1936243,1936143,1936142,1936140,1936141,1936247,1936246,1823000,1816052,1181055,1712020,1712018,1712017,495364,1721276,1727017,1673980,1717914,1543183,1945209,1945207,1945206,1542758,1772726,1772737,1530796,1751785,1749654,1184820,1125136,1635487,1526857,1946151,1946152,1705018,1639688,1631070,1923529,1727356,1947312,1727352,1871923,1924145,1933227,1946169,1907666,583033,44367,1910402,1186219,1531114,839070,1531115,1531118,1531116,1186962,1522271,1522261,1555148,1587596,1626742,1908422,1922304,1838398,1946165,1907611,1946166,1946163,1946164,1204330,1330558,1689417,1727299,1724013,1697401,1697407,1697403,1933498,1367306,1128631,1122311,1338914,1752617,1919306,1724281,1615900,1615910,1615905,1335615,1615901,1364690,1093721,1933508,1563865,36607,1196884,1421673,1429160,1704793,1947714,1947723,1630195,1408912,1947720,1422335,1944920,1947715,1947717,1920590,1767069,1400984,1725916,1838913,1911748,1920598,1759114,1759111,1759113,1759112,1756215,1527368,1527373,1527369,1729864,1381367,1198325,1198443,1100754,1094565,1682484,1615625,1613657,1656781,1932808,1922338,1725858,1085189,1383934,1248874,1744522,463445,1452648,1339586,1204839,1779113,1505731,1682743,1730006,1847621,1654485,1947418,1924093,1611774,1555275,1654102,1006610,1908519,1911422,1925070,1546223,1940610,872606,1674549,1564293,1223317,1097536,978656,1915119,1727348,1941669,1945372,598358,771356,1930538,1653987,1947178,1946380,1400380,1749625,1946655,60254,60273,33387,33398,1045250,666711,1855251,500826,526836,1729856) and qt.job_name != 'WSRetryJob' AND qt.job_group != 'BaseLine' Order by qt.next_fire_time desc 2023-05-03/04:20:32.937 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - 2023-05-03/04:20:32.937 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - onlyTriggerQuery .. select qt.job_name, qt.job_group, qt.trigger_name, qt.trigger_group, qt.next_fire_time, qct.CRON_EXPRESSION from qrtz_triggers qt left join qrtz_cron_triggers qct on qct.TRIGGER_NAME = qt.TRIGGER_NAME where 1=1 and qt.job_name not in ('AnalyticsJob','AnalyticsESJob') and qt.job_name != 'WSRetryJob' AND qt.job_group != 'BaseLine' Order by qt.next_fire_time desc 2023-05-03/04:20:32.953 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - Before fetching jobEnddate and SavResponse from EcmImportJob first element from qrtzTriggerDataList : [job_name:WSBlockingRetryJob, job_group:utility, trigger_name:5ADAPPS_PENDING_ACCESS, trigger_group:GRAILS_JOBS, next_fire_time:4070945820000, CRON_EXPRESSION:0 17 10 * * ? 2099] 2023-05-03/04:20:32.955 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - After fetching jobEnddate and SavResponse from EcmImportJob first element from qrtzTriggerDataList : [job_name:WSBlockingRetryJob, job_group:utility, trigger_name:5ADAPPS_PENDING_ACCESS, trigger_group:GRAILS_JOBS, next_fire_time:4070945820000, CRON_EXPRESSION:0 17 10 * * ? 2099, SAVRESPONSE:Success, prev_fire_time:2022-05-31 11:26:34.0] 2023-05-03/04:20:32.955 [{}] [https-jsse-nio-443-exec-9] DEBUG domain.FlatViewJobcontrolController - totalData 611 2023-05-03/04:20:33.216 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - getJobCount - params: [importType:null, jobType:null, secSysId:null, jobName:'WSRetryJob','MultipleProvisioningJob', parentJobId:1947731, isMultiJob:true, connectionType:null, callFromRunAllAnalyticsJob:null] 2023-05-03/04:20:33.245 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Testing-JobDataMap.size : 5 2023-05-03/04:20:33.246 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - jobCount: 1 2023-05-03/04:20:33.246 [{}] [quartzScheduler_Worker-7] DEBUG integration.ExternalConnectionCallService - jobCount 1 2023-05-03/04:20:33.246 [{}] [quartzScheduler_Worker-7] DEBUG integration.ExternalConnectionCallService - Consolidate child's importlog 2023-05-03/04:20:33.246 [{}] [quartzScheduler_Worker-7] DEBUG integration.ExternalConnectionCallService - parentJobId 1947731 2023-05-03/04:20:33.293 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - ecmjobIdQuery .. select max(eij.JOBID) as 'JobId' from EcmImportJob eij where eij.TRIGGERNAME in (select qrt.TRIGGER_NAME from qrtz_triggers qrt) group by eij.TRIGGERNAME 2023-05-03/04:20:35.585 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - jobIdList size = 711 2023-05-03/04:20:35.638 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - 2023-05-03/04:20:35.638 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - jobAndTriggerQuery .. select e.SAVRESPONSE, e.JOBENDDATE as prev_fire_time, qt.job_name, qt.job_group, qt.trigger_name,qt.trigger_group,qt.next_fire_time, qct.CRON_EXPRESSION from qrtz_triggers qt left join ecmimportjob e on e.TRIGGERNAME=qt.TRIGGER_NAME left join qrtz_cron_triggers qct on qct.TRIGGER_NAME = qt.TRIGGER_NAME where e.JOBID in(1772972,1935046,1711909,1703140,1554327,1919697,1922381,1761151,1684585,1919289,1204523,1213046,928841,1200420,1381380,1205377,1675709,1947125,1189311,979441,1758246,1727037,1936245,1756060,1946191,1686339,1758223,1727969,1668750,1947185,1770540,1947377,1198661,1756226,1199130,1199578,1756223,1869522,1871990,1888099,1947241,1193784,1199231,1690230,1724029,1392140,1668109,1941197,1941193,1947529,1643088,1643090,1643089,1888485,1204313,635647,512950,512081,1891869,1645748,1910119,670955,1941638,1934867,1710284,1849892,1181172,1682290,1682276,1708555,1671091,1484826,1947363,1749697,1401532,1945340,1945324,1946587,1714509,1674048,1674049,1945323,1947113,1675992,1675894,821,1967,561072,1711366,2217,1308653,723706,2328,689298,3257,1441663,963653,959706,965292,1654138,6162,1315985,1055703,1084630,1122401,14171,1125666,1199867,15224,1652710,18648,1264604,20222,1306472,1451905,1330846,1360531,1364313,1365439,112432,1380488,1726701,1399800,1507328,1507329,1507330,1429564,1433886,1507358,1507359,1467623,1472735,1507360,1485059,1501919,1522262,1544879,1527113,1544870,1563806,1580834,1584583,1608989,1625068,1711368,1640562,1640630,1640807,1642362,1644416,1647783,1654148,1653932,1654206,1654436,1654476,1655532,1664269,1664511,1664907,1758584,1672414,1674381,1676160,1676075,1676415,1682739,1682770,1682880,1682969,1684279,1706150,1710135,1711369,1711367,1723942,1727036,1724442,1726632,1726837,1726883,1727353,1748503,1730836,1734249,1745323,1745529,1755550,1759234,1790881,1796937,1838712,1822882,1829868,29541,1871924,1918733,1940807,1940611,36546,123950,133179,690,153057,153526,288245,224321,224469,233339,701,260811,287791,287441,726,451018,499650,1761587,1761071,513039,1508187,1760203,1710299,1933384,1842125,1672352,1772702,1772716,1606282,1613809,1684471,1653806,1606275,1613802,1684563,1772713,1608715,1613932,1682760,1725534,1654532,1606274,1613800,1684562,1533617,1587892,1606273,1613799,1684561,1947729,1352193,1752380,1752382,1312111,1772704,523875,1922342,1936732,1946172,1936733,1946186,1571756,1875128,1933242,504670,1897014,1745239,1700873,1639422,1745234,1467969,490584,1310707,1925052,1910002,1921306,1175401,1910454,1947731,1120510,1670827,1946144,1772635,1772643,1717663,1654127,153812,1060752,1770504,1772634,1045075,1195000,1579276,1945585,1674744,1873069,500592,1204845,1888307,1187572,876424,1187053,1947086,1668111,1947304,1199513,1737625,1734300,1453824,1791000,1503193,1790878,1749457,1200014,1730275,1749322,1761563,1543252,1896944,1880174,1896942,1682769,1749690,1755831,1918679,1770434,1922306,1877139,1922305,1933449,1228034,1752383,1947730,1668104,1947236,1888260,1869576,1947253,1896519,1942005,1831390,1869535,1947722,1946150,1180484,1947728,1474328,920634,1471272,1945975,1945862,1943267,1630071,1945865,1942444,1945979,1942557,1943271,1936731,1630750,1630771,1654150,1935018,484169,527743,1911233,348581,527744,527979,89335,1263721,1339416,1339418,1339417,1315862,1630401,1716831,1630847,1339870,1946175,1280544,1280546,1280545,1280549,1280555,1280551,500596,565,1947492,1947491,1947490,1527408,1527410,1527409,1752384,1772776,1945605,864274,722369,583338,1726990,1759019,1682744,1837982,1945448,1611415,1946663,1769381,1743485,1946605,1918757,1918762,1513594,1513593,1513595,1726790,1946607,1564353,1946573,1776190,1946574,1627146,1946660,1138945,1339744,1205411,1946656,1924017,1473004,998559,580389,1947716,580518,580582,1072222,758896,580711,580774,1492337,88400,1044861,1761726,1761826,1654254,1326034,1180483,1395261,1701358,1781999,1781978,1758597,1734144,1782119,1946168,645502,1045255,1648045,959850,1656506,1505828,1505832,1505829,1435525,1630735,1630313,1631255,1717635,1630556,1674020,1712021,1726978,1725163,1674013,1725289,1945316,1945443,1945317,1946153,1946154,1454857,1473049,1552418,1397462,1668801,1416212,1352929,1094775,1366413,1704130,54431,1750104,1725405,1750134,1399764,1404528,495329,1630337,580187,527659,1910615,1400764,1755471,1459615,648626,1494614,1306513,1311374,1367253,1315960,1352648,562786,1725498,1725499,1725579,1671376,1772703,1648319,1639721,1724555,1640639,1772708,1709331,1936243,1936143,1936142,1936140,1936141,1936247,1936246,1823000,1816052,1181055,1712020,1712018,1712017,495364,1721276,1727017,1673980,1717914,1543183,1945209,1945207,1945206,1542758,1772726,1772737,1530796,1751785,1749654,1184820,1125136,1635487,1526857,1946151,1946152,1705018,1639688,1631070,1923529,1727356,1947312,1727352,1871923,1924145,1933227,1946169,1907666,583033,44367,1910402,1186219,1531114,839070,1531115,1531118,1531116,1186962,1522271,1522261,1555148,1587596,1626742,1908422,1922304,1838398,1946165,1907611,1946166,1946163,1946164,1204330,1330558,1689417,1727299,1724013,1697401,1697407,1697403,1933498,1367306,1128631,1122311,1338914,1752617,1919306,1724281,1615900,1615910,1615905,1335615,1615901,1364690,1093721,1933508,1563865,36607,1196884,1421673,1429160,1704793,1947714,1947723,1630195,1408912,1947720,1422335,1944920,1947715,1947717,1920590,1767069,1400984,1725916,1838913,1911748,1920598,1759114,1759111,1759113,1759112,1756215,1527368,1527373,1527369,1729864,1381367,1198325,1198443,1100754,1094565,1682484,1615625,1613657,1656781,1932808,1922338,1725858,1085189,1383934,1248874,1744522,463445,1452648,1339586,1204839,1779113,1505731,1682743,1730006,1847621,1654485,1947418,1924093,1611774,1555275,1654102,1006610,1908519,1911422,1925070,1546223,1940610,872606,1674549,1564293,1223317,1097536,978656,1915119,1727348,1941669,1945372,598358,771356,1930538,1653987,1947178,1946380,1400380,1749625,1946655,60254,60273,33387,33398,1045250,666711,1855251,500826,526836,1729856) and qt.job_name != 'WSRetryJob' AND qt.job_group != 'BaseLine' Order by qt.next_fire_time desc 2023-05-03/04:20:35.638 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - 2023-05-03/04:20:35.638 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - onlyTriggerQuery .. select qt.job_name, qt.job_group, qt.trigger_name, qt.trigger_group, qt.next_fire_time, qct.CRON_EXPRESSION from qrtz_triggers qt left join qrtz_cron_triggers qct on qct.TRIGGER_NAME = qt.TRIGGER_NAME where 1=1 and qt.job_name not in ('AnalyticsJob','AnalyticsESJob') and qt.job_name != 'WSRetryJob' AND qt.job_group != 'BaseLine' Order by qt.next_fire_time desc 2023-05-03/04:20:35.644 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - Before fetching jobEnddate and SavResponse from EcmImportJob first element from qrtzTriggerDataList : [job_name:WSBlockingRetryJob, job_group:utility, trigger_name:5ADAPPS_PENDING_ACCESS, trigger_group:GRAILS_JOBS, next_fire_time:4070945820000, CRON_EXPRESSION:0 17 10 * * ? 2099] 2023-05-03/04:20:35.646 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - After fetching jobEnddate and SavResponse from EcmImportJob first element from qrtzTriggerDataList : [job_name:WSBlockingRetryJob, job_group:utility, trigger_name:5ADAPPS_PENDING_ACCESS, trigger_group:GRAILS_JOBS, next_fire_time:4070945820000, CRON_EXPRESSION:0 17 10 * * ? 2099, SAVRESPONSE:Success, prev_fire_time:2022-05-31 11:26:34.0] 2023-05-03/04:20:35.646 [{}] [https-jsse-nio-443-exec-4] DEBUG domain.FlatViewJobcontrolController - totalData 611 2023-05-03/04:20:40.992 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - MultipleProvisioningJob Job End for job id 1947732 - jobcomment-invoked from WSRetryJob ID - 1947731 group 0 2023-05-03/04:20:40.992 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - allTaskKeys: 1 2023-05-03/04:20:40.992 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Enter doSodEval, allTaskKeys: 1 2023-05-03/04:20:40.993 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Query to get Request_Exceptions from tasks: select distinct re.REQUEST_EXCEPTIONSKEY, re.USERKEY, re.EXCEPTIONKEY from arstasks at, request_exceptions re where at.REQUESTKEY = re.REQUESTKEY and at.TASKKEY in (1302205) 2023-05-03/04:20:40.993 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - resultList: 0 2023-05-03/04:20:41.011 [{}] [quartzScheduler_Worker-7] DEBUG services.ArsTaskHelperService - Exit doSodEval 2023-05-03/04:20:41.011 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - tasks found.. 2023-05-03/04:20:41.011 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - removing entries from ARSTASKS_EXEC table done 2023-05-03/04:20:41.012 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Enter removetasksfromexecution 2023-05-03/04:20:41.012 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Entries to remove = [1302205] 2023-05-03/04:20:41.012 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Entries remove start 2023-05-03/04:20:41.042 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Entries remove finish 2023-05-03/04:20:41.042 [{}] [quartzScheduler_Worker-7] DEBUG services.SaviyntCommonUtilityService - Exit removetasksfromexecution 2023-05-03/04:20:41.042 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - removing entries from ARSTASKS_EXEC table done 2023-05-03/04:20:41.042 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - MultipleProvisioningJob Job End for job id 1947732 - jobcomment-invoked from WSRetryJob ID - 1947731 group 0 2023-05-03/04:20:41.042 [{}] [quartzScheduler_Worker-7] DEBUG jobs.MultipleProvisioningJob - Exit MultipleProvisioningJob 2023-05-03/04:20:41.229 [{}] [pool-5-thread-1] ERROR cmd.ExecuteJobCmd - exception while executing 'ExecuteEventListenerMessage[46745526]' javax.el.PropertyNotFoundException: Cannot resolve identifier 'requestaccesskey' at de.odysseus.el.tree.impl.ast.AstIdentifier.eval(AstIdentifier.java:86) at de.odysseus.el.tree.impl.ast.AstEval.eval(AstEval.java:51) at de.odysseus.el.tree.impl.ast.AstComposite.eval(AstComposite.java:35) at de.odysseus.el.tree.impl.ast.AstNode.getValue(AstNode.java:28) at de.odysseus.el.TreeValueExpression.getValue(TreeValueExpression.java:122) at org.jbpm.pvm.internal.el.UelValueExpression.evaluateInScope(UelValueExpression.java:52) at org.jbpm.pvm.internal.el.Expression.evaluate(Expression.java:108) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:143) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:139) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.fillContent(MailProducerImpl.java:251) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.produce(MailProducerImpl.java:84) at org.jbpm.jpdl.internal.activity.MailListener.notify(MailListener.java:58) at org.jbpm.pvm.internal.model.op.ExecuteEventListener.perform(ExecuteEventListener.java:81) at org.jbpm.pvm.internal.model.ExecutionImpl.performAtomicOperationSync(ExecutionImpl.java:672) at org.jbpm.pvm.internal.model.op.ExecuteEventListenerMessage.executeVoid(ExecuteEventListenerMessage.java:153) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:46) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:32) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:79) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:41) at org.jbpm.pvm.internal.svc.DefaultCommandService.execute(DefaultCommandService.java:42) at org.jbpm.pvm.internal.tx.SpringCommandCallback.doInTransaction(SpringCommandCallback.java:45) at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:131) at org.jbpm.pvm.internal.tx.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:49) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.executeInNewEnvironment(EnvironmentInterceptor.java:53) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.execute(EnvironmentInterceptor.java:40) at org.jbpm.pvm.internal.svc.RetryInterceptor.execute(RetryInterceptor.java:56) at org.jbpm.pvm.internal.jobexecutor.JobParcel.run(JobParcel.java:48) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 2023-05-03/04:20:41.246 [{}] [pool-5-thread-1] ERROR jobexecutor.JobParcel - failed to execute job: 46745526 javax.el.PropertyNotFoundException: Cannot resolve identifier 'requestaccesskey' at de.odysseus.el.tree.impl.ast.AstIdentifier.eval(AstIdentifier.java:86) at de.odysseus.el.tree.impl.ast.AstEval.eval(AstEval.java:51) at de.odysseus.el.tree.impl.ast.AstComposite.eval(AstComposite.java:35) at de.odysseus.el.tree.impl.ast.AstNode.getValue(AstNode.java:28) at de.odysseus.el.TreeValueExpression.getValue(TreeValueExpression.java:122) at org.jbpm.pvm.internal.el.UelValueExpression.evaluateInScope(UelValueExpression.java:52) at org.jbpm.pvm.internal.el.Expression.evaluate(Expression.java:108) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:143) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:139) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.fillContent(MailProducerImpl.java:251) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.produce(MailProducerImpl.java:84) at org.jbpm.jpdl.internal.activity.MailListener.notify(MailListener.java:58) at org.jbpm.pvm.internal.model.op.ExecuteEventListener.perform(ExecuteEventListener.java:81) at org.jbpm.pvm.internal.model.ExecutionImpl.performAtomicOperationSync(ExecutionImpl.java:672) at org.jbpm.pvm.internal.model.op.ExecuteEventListenerMessage.executeVoid(ExecuteEventListenerMessage.java:153) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:46) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:32) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:79) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:41) at org.jbpm.pvm.internal.svc.DefaultCommandService.execute(DefaultCommandService.java:42) at org.jbpm.pvm.internal.tx.SpringCommandCallback.doInTransaction(SpringCommandCallback.java:45) at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:131) at org.jbpm.pvm.internal.tx.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:49) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.executeInNewEnvironment(EnvironmentInterceptor.java:53) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.execute(EnvironmentInterceptor.java:40) at org.jbpm.pvm.internal.svc.RetryInterceptor.execute(RetryInterceptor.java:56) at org.jbpm.pvm.internal.jobexecutor.JobParcel.run(JobParcel.java:48) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 2023-05-03/04:20:41.380 [{}] [pool-5-thread-3] ERROR cmd.ExecuteJobCmd - exception while executing 'ExecuteEventListenerMessage[46745526]' javax.el.PropertyNotFoundException: Cannot resolve identifier 'requestaccesskey' at de.odysseus.el.tree.impl.ast.AstIdentifier.eval(AstIdentifier.java:86) at de.odysseus.el.tree.impl.ast.AstEval.eval(AstEval.java:51) at de.odysseus.el.tree.impl.ast.AstComposite.eval(AstComposite.java:35) at de.odysseus.el.tree.impl.ast.AstNode.getValue(AstNode.java:28) at de.odysseus.el.TreeValueExpression.getValue(TreeValueExpression.java:122) at org.jbpm.pvm.internal.el.UelValueExpression.evaluateInScope(UelValueExpression.java:52) at org.jbpm.pvm.internal.el.Expression.evaluate(Expression.java:108) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:143) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:139) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.fillContent(MailProducerImpl.java:251) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.produce(MailProducerImpl.java:84) at org.jbpm.jpdl.internal.activity.MailListener.notify(MailListener.java:58) at org.jbpm.pvm.internal.model.op.ExecuteEventListener.perform(ExecuteEventListener.java:81) at org.jbpm.pvm.internal.model.ExecutionImpl.performAtomicOperationSync(ExecutionImpl.java:672) at org.jbpm.pvm.internal.model.op.ExecuteEventListenerMessage.executeVoid(ExecuteEventListenerMessage.java:153) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:46) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:32) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:79) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:41) at org.jbpm.pvm.internal.svc.DefaultCommandService.execute(DefaultCommandService.java:42) at org.jbpm.pvm.internal.tx.SpringCommandCallback.doInTransaction(SpringCommandCallback.java:45) at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:131) at org.jbpm.pvm.internal.tx.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:49) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.executeInNewEnvironment(EnvironmentInterceptor.java:53) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.execute(EnvironmentInterceptor.java:40) at org.jbpm.pvm.internal.svc.RetryInterceptor.execute(RetryInterceptor.java:56) at org.jbpm.pvm.internal.jobexecutor.JobParcel.run(JobParcel.java:48) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 2023-05-03/04:20:41.395 [{}] [pool-5-thread-3] ERROR jobexecutor.JobParcel - failed to execute job: 46745526 javax.el.PropertyNotFoundException: Cannot resolve identifier 'requestaccesskey' at de.odysseus.el.tree.impl.ast.AstIdentifier.eval(AstIdentifier.java:86) at de.odysseus.el.tree.impl.ast.AstEval.eval(AstEval.java:51) at de.odysseus.el.tree.impl.ast.AstComposite.eval(AstComposite.java:35) at de.odysseus.el.tree.impl.ast.AstNode.getValue(AstNode.java:28) at de.odysseus.el.TreeValueExpression.getValue(TreeValueExpression.java:122) at org.jbpm.pvm.internal.el.UelValueExpression.evaluateInScope(UelValueExpression.java:52) at org.jbpm.pvm.internal.el.Expression.evaluate(Expression.java:108) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:143) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:139) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.fillContent(MailProducerImpl.java:251) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.produce(MailProducerImpl.java:84) at org.jbpm.jpdl.internal.activity.MailListener.notify(MailListener.java:58) at org.jbpm.pvm.internal.model.op.ExecuteEventListener.perform(ExecuteEventListener.java:81) at org.jbpm.pvm.internal.model.ExecutionImpl.performAtomicOperationSync(ExecutionImpl.java:672) at org.jbpm.pvm.internal.model.op.ExecuteEventListenerMessage.executeVoid(ExecuteEventListenerMessage.java:153) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:46) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:32) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:79) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:41) at org.jbpm.pvm.internal.svc.DefaultCommandService.execute(DefaultCommandService.java:42) at org.jbpm.pvm.internal.tx.SpringCommandCallback.doInTransaction(SpringCommandCallback.java:45) at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:131) at org.jbpm.pvm.internal.tx.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:49) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.executeInNewEnvironment(EnvironmentInterceptor.java:53) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.execute(EnvironmentInterceptor.java:40) at org.jbpm.pvm.internal.svc.RetryInterceptor.execute(RetryInterceptor.java:56) at org.jbpm.pvm.internal.jobexecutor.JobParcel.run(JobParcel.java:48) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 2023-05-03/04:20:41.535 [{}] [pool-5-thread-4] ERROR cmd.ExecuteJobCmd - exception while executing 'ExecuteEventListenerMessage[46745526]' javax.el.PropertyNotFoundException: Cannot resolve identifier 'requestaccesskey' at de.odysseus.el.tree.impl.ast.AstIdentifier.eval(AstIdentifier.java:86) at de.odysseus.el.tree.impl.ast.AstEval.eval(AstEval.java:51) at de.odysseus.el.tree.impl.ast.AstComposite.eval(AstComposite.java:35) at de.odysseus.el.tree.impl.ast.AstNode.getValue(AstNode.java:28) at de.odysseus.el.TreeValueExpression.getValue(TreeValueExpression.java:122) at org.jbpm.pvm.internal.el.UelValueExpression.evaluateInScope(UelValueExpression.java:52) at org.jbpm.pvm.internal.el.Expression.evaluate(Expression.java:108) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:143) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:139) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.fillContent(MailProducerImpl.java:251) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.produce(MailProducerImpl.java:84) at org.jbpm.jpdl.internal.activity.MailListener.notify(MailListener.java:58) at org.jbpm.pvm.internal.model.op.ExecuteEventListener.perform(ExecuteEventListener.java:81) at org.jbpm.pvm.internal.model.ExecutionImpl.performAtomicOperationSync(ExecutionImpl.java:672) at org.jbpm.pvm.internal.model.op.ExecuteEventListenerMessage.executeVoid(ExecuteEventListenerMessage.java:153) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:46) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:32) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:79) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:41) at org.jbpm.pvm.internal.svc.DefaultCommandService.execute(DefaultCommandService.java:42) at org.jbpm.pvm.internal.tx.SpringCommandCallback.doInTransaction(SpringCommandCallback.java:45) at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:131) at org.jbpm.pvm.internal.tx.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:49) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.executeInNewEnvironment(EnvironmentInterceptor.java:53) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.execute(EnvironmentInterceptor.java:40) at org.jbpm.pvm.internal.svc.RetryInterceptor.execute(RetryInterceptor.java:56) at org.jbpm.pvm.internal.jobexecutor.JobParcel.run(JobParcel.java:48) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 2023-05-03/04:20:41.550 [{}] [pool-5-thread-4] ERROR jobexecutor.JobParcel - failed to execute job: 46745526 javax.el.PropertyNotFoundException: Cannot resolve identifier 'requestaccesskey' at de.odysseus.el.tree.impl.ast.AstIdentifier.eval(AstIdentifier.java:86) at de.odysseus.el.tree.impl.ast.AstEval.eval(AstEval.java:51) at de.odysseus.el.tree.impl.ast.AstComposite.eval(AstComposite.java:35) at de.odysseus.el.tree.impl.ast.AstNode.getValue(AstNode.java:28) at de.odysseus.el.TreeValueExpression.getValue(TreeValueExpression.java:122) at org.jbpm.pvm.internal.el.UelValueExpression.evaluateInScope(UelValueExpression.java:52) at org.jbpm.pvm.internal.el.Expression.evaluate(Expression.java:108) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:143) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.evaluateExpression(MailProducerImpl.java:139) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.fillContent(MailProducerImpl.java:251) at org.jbpm.pvm.internal.email.impl.MailProducerImpl.produce(MailProducerImpl.java:84) at org.jbpm.jpdl.internal.activity.MailListener.notify(MailListener.java:58) at org.jbpm.pvm.internal.model.op.ExecuteEventListener.perform(ExecuteEventListener.java:81) at org.jbpm.pvm.internal.model.ExecutionImpl.performAtomicOperationSync(ExecutionImpl.java:672) at org.jbpm.pvm.internal.model.op.ExecuteEventListenerMessage.executeVoid(ExecuteEventListenerMessage.java:153) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:46) at org.jbpm.pvm.internal.job.MessageImpl.execute(MessageImpl.java:32) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:79) at org.jbpm.pvm.internal.cmd.ExecuteJobCmd.execute(ExecuteJobCmd.java:41) at org.jbpm.pvm.internal.svc.DefaultCommandService.execute(DefaultCommandService.java:42) at org.jbpm.pvm.internal.tx.SpringCommandCallback.doInTransaction(SpringCommandCallback.java:45) at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:131) at org.jbpm.pvm.internal.tx.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:49) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.executeInNewEnvironment(EnvironmentInterceptor.java:53) at org.jbpm.pvm.internal.svc.EnvironmentInterceptor.execute(EnvironmentInterceptor.java:40) at org.jbpm.pvm.internal.svc.RetryInterceptor.execute(RetryInterceptor.java:56) at org.jbpm.pvm.internal.jobexecutor.JobParcel.run(JobParcel.java:48) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at java.lang.Thread.run(Thread.java:748) 2023-05-03/04:20:42.215 [{}] [pool-5-thread-1] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:42.284 [{}] [pool-5-thread-3] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:42.475 [{}] [pool-5-thread-2] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:42.542 [{}] [pool-5-thread-1] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:43.256 [{}] [pool-5-thread-5] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:43.330 [{}] [pool-5-thread-2] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:43.592 [{}] [pool-5-thread-3] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:44.237 [{}] [pool-5-thread-2] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:44.309 [{}] [pool-5-thread-1] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:44.500 [{}] [pool-5-thread-5] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:44.564 [{}] [pool-5-thread-2] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:45.219 [{}] [pool-5-thread-4] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:45.284 [{}] [pool-5-thread-5] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:45.517 [{}] [pool-5-thread-1] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:46.239 [{}] [pool-5-thread-5] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:46.309 [{}] [pool-5-thread-2] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:46.489 [{}] [pool-5-thread-4] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:46.552 [{}] [pool-5-thread-5] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:47.205 [{}] [pool-5-thread-3] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:47.268 [{}] [pool-5-thread-4] DEBUG println.PrintlnToLogger - Println :: INSERT =1 2023-05-03/04:20:52.152 [{}] [https-jsse-nio-443-exec-24] DEBUG controllers.LogsController - Entered downloadMultiLogs 2023-05-03/04:20:52.152 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - logFileAndPath: /opt/sharedappdrive/saviynt/logs/error-100.64.180.82.log 2023-05-03/04:20:52.152 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - Entered getLogFiles 2023-05-03/04:20:52.228 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - logFiles before sorting : 2023-05-03/04:20:52.229 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - logFiles after sorting : 2023-05-03/04:20:52.229 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - Enter getFileName 2023-05-03/04:20:52.229 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - finalFileName = debugLog-100.64.180.82.log 2023-05-03/04:20:52.229 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - Exit getFileName 2023-05-03/04:20:52.229 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - logFileAndPath: /opt/sharedappdrive/saviynt/logs/error-100.64.180.82.log 2023-05-03/04:20:52.230 [{}] [https-jsse-nio-443-exec-24] DEBUG log.LoggerService - Files to Zip = [/opt/sharedappdrive/saviynt/logs/debugLog-100.64.180.82.log] 2023-05-03/04:20:52.230 [{}] [https-jsse-nio-443-exec-24] DEBUG export.ExcelExportService - Enter createZipFile 2023-05-03/04:20:52.908 [{}] [quartzScheduler_Worker-9] DEBUG jobs.WSBlockingRetryJob - jobsoncluster = 1 2023-05-03/04:20:52.909 [{}] [quartzScheduler_Worker-9] DEBUG jobs.WSBlockingRetryJob - No Multiple provisioning job running on cluster.. exiting 2023-05-03/04:20:52.909 [{}] [quartzScheduler_Worker-9] DEBUG jobs.WSBlockingRetryJob - no more Multiple provisioning jobs running