ASAP 7.3 Taking Too Long To Start (Doc ID 2464550.1)

Last updated on FEBRUARY 19, 2024

Applies to:

Symptoms

On : 7.3.0.0.0 version, Performance Issues

ACTUAL BEHAVIOR
---------------

We are deploying 7.3.0.3 ASAP with Oracle DB 12c in production environments and found that ASAP is taking around 20 mins to start up with 22 components. ASAP has 10 custom NEPs.

In our legacy production instance even though 38 processes are there, it takes less than 10 mins to start. Due to higher start up time, complete loss of service will be there till ASAP comes up.

Looks like for each ASAP server, there is a significant delay( about 10 seconds) while establishing DB connection pool:

SARM:

>> 111415.120:6: LOW:ASC Security Init        :681 :control/libcontrol/asc_security.c
Finished checking initial security information for [<SARM_USER>]
>> 111427.572:6: LOW:SessionPool_Create       :1578:control/libasc/ocilib.c
OCISessionPool Created Successfully,status[1] - POOLNAME:[OCI:SP:dT25nJZYXnfgU8kKJQrhaA] POOLLENGTH:[29]
>> 111427.572:6: LOW:ASC_cpdbpcreate          :126 :control/libcontrol/ctlib.c
Successfully created Session Pool for pool:Control_Pool


>> 111427.580:6:SANE:ASC Init                 :606 :control/libcontrol/ctlib.c
Encryption level (1), cache mode (0), audit level(0)
>> 111444.182:6: LOW:SessionPool_Create       :1578:control/libasc/ocilib.c
OCISessionPool Created Successfully,status[1] - POOLNAME:[OCI:SP:dT25nJZoXnfgU8kKJQrhaA] POOLLENGTH:[29]
>> 111444.182:6: LOW:ASC_cpdbpcreate          :126 :control/libcontrol/ctlib.c
Successfully created Session Pool for pool:Application_Pool


>> 111445.380:6:SANE:Load Cfg Tables          :363 :sarm/sarm/sarm/lookup_tbl.c
Loading persistent CSDL and ASDL data.
>> 111445.404:6: LOW:Get Secure Data          :314 :control/libcontrol/asc_security.c
Password successfully retrieved for user: [<ADM_USER>]
>> 111445.404:6: LOW:Get Secure Data          :345 :control/libcontrol/asc_security.c
ASC_get_securedata is done - name[<ADM_USER>], class[0]
>> 111445.404:6: LOW:ASC_cpalloc              :2190:control/libasc/ctlib.c
CS_MAX_CONNECT property set to [25] max connections per context
>> 111455.006:6: LOW:ASC_cprpcexec()          :1244:control/libasc/ctlib.c
Executing RPC [ASP_get_last_csdl]. Retry Count [0]
>> 111455.006:6: LOW:ASC_ocicreate_cmd        :289 :control/libasc/ocilib.c
Created PL/SQL statement as follows : begin :retval :=ASP_get_last_csdl(:curs,:sarm); end;


ADM:

>> 111339.673:5: LOW:ASC Security Init        :681 :control/libcontrol/asc_security.c
Finished checking initial security information for [<ADM_USER>]
>> 111351.533:5: LOW:SessionPool_Create       :1578:control/libasc/ocilib.c
OCISessionPool Created Successfully,status[1] - POOLNAME:[OCI:SP:dT23vLEEXVHgU8kKJQoBTD] POOLLENGTH:[29]
>> 111351.533:5: LOW:ASC_cpdbpcreate          :126 :control/libcontrol/ctlib.c
Successfully created Session Pool for pool:Control_Pool

>> 111351.537:5:SANE:ASC Init                 :606 :control/libcontrol/ctlib.c
Encryption level (1), cache mode (0), audit level(0)
>> 111401.542:5: LOW:SessionPool_Create       :1578:control/libasc/ocilib.c
OCISessionPool Created Successfully,status[1] - POOLNAME:[OCI:SP:dT23vLEUXVHgU8kKJQoBTD] POOLLENGTH:[29]
>> 111401.542:5: LOW:ASC_cpdbpcreate          :126 :control/libcontrol/ctlib.c
Successfully created Session Pool for pool:Application_Pool

NEP_PRD1:


>> 111259.573:7: LOW:Get Secure Data          :345 :control/libcontrol/asc_security.c
ASC_get_securedata is done - name[<NEP_USER_NAEM>], class[0]
>> 111309.179:7: LOW:SessionPool_Create       :1578:control/libasc/ocilib.c
OCISessionPool Created Successfully,status[1] - POOLNAME:[OCI:SP:dT2zxWVzWongU8kKJQo5uC] POOLLENGTH:[29]
>> 111309.179:7: LOW:ASC_cpdbpcreate          :126 :control/libcontrol/ctlib.c
Successfully created Session Pool for pool:CMD cpp

>> 111309.230:7: LOW:Get Secure Data          :345 :control/libcontrol/asc_security.c
ASC_get_securedata is done - name[<SARM_USER_NAME>], class[0]
>> 111319.205:7: LOW:SessionPool_Create       :1578:control/libasc/ocilib.c
OCISessionPool Created Successfully,status[1] - POOLNAME:[OCI:SP:dT2zxWV2WongU8kKJQo5uC] POOLLENGTH:[29]
>> 111319.205:7: LOW:ASC_cpdbpcreate          :126 :control/libcontrol/ctlib.c
Successfully created Session Pool for pool:Core cpp
>> 111319.207:7: LOW:ASC_cpalloc              :2190:control/libasc/ctlib.c
CS_MAX_CONNECT property set to [25] max connections per context
>> 111319.208:7: LOW:ASC_cpalloc              :2190:control/libasc/ctlib.c
CS_MAX_CONNECT property set to [25] max connections per context
>> 111329.179:7: LOW:SessionPool_Create       :1578:control/libasc/ocilib.c
OCISessionPool Created Successfully,status[1] - POOLNAME:[OCI:SP:dT2zxWV5WongU8kKJQo5uC] POOLLENGTH:[29]
>> 111329.179:7: LOW:ASC_cpdbpcreate          :126 :control/libcontrol/ctlib.c
Successfully created Session Pool for pool:Core Pool

Cause

My Oracle Support provides customers with access to over a million knowledge articles and a vibrant support community of peers and Oracle experts.