Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250721220008\orcl_vkrm_15216_bucket.trc Oracle Database 11g Enterprise Edition Release 11.2.0.1.0 - 64bit Production With the Partitioning, OLAP, Data Mining and Real Application Testing options Windows NT Version V6.2 CPU : 32 - type 8664, 16 Physical Cores Process Affinity : 0x0x0000000000000000 Memory (Avail/Total): Ph:36115M/63366M, Ph+PgF:41997M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 15216, image: ORACLE.EXE (VKRM) *** 2025-07-21 22:00:08.388 *** SESSION ID:(177.43003) 2025-07-21 22:00:08.388 *** 2025-07-21 22:00:08.388 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=15216, pid: 22, proc_ser: 224, sid: 177, sess_ser: 43003 ------------------------------------------------------------------------------- current sql: Current Wait Stack: 0: waiting for 'VKRM Idle' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=8.375307 sec, exc=8.375307 sec, total=8.375307 sec wait times: max=infinite, heur=8.375307 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000000 sec since current wait Sampled Session History of session 177 serial 43003 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [9 samples, 22:00:00 - 22:00:08] idle wait at each sample [session created at: 22:00:00] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-21 22:00:08.388 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 15216, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-21 21:56:00.265213 :B52B8880:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:56:30.351766 :B52B9266:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:56:36.349403 :B52B9443:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:56:36.340 2025-07-21 21:56:36.349405 :B52B9444:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18880 pso_num=22 pso_serial#=203 2025-07-21 21:56:36.349541 :B52B9445:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18880 (legacy spawn) 2025-07-21 21:56:36.355960 :B52B9446:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:56:36.356153 :B52B944F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:56:36.356972 :B52B9450:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:56:49.903400 :B52B9887:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:56:49.890 2025-07-21 21:56:49.903402 :B52B9888:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16392 pso_num=22 pso_serial#=204 2025-07-21 21:56:49.903542 :B52B9889:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16392 (legacy spawn) 2025-07-21 21:56:49.910074 :B52B988A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:56:49.910263 :B52B9893:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:56:49.911050 :B52B9894:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:56:58.893226 :B52B9B56:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:56:58.879 2025-07-21 21:56:58.893228 :B52B9B57:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18940 pso_num=22 pso_serial#=205 2025-07-21 21:56:58.893359 :B52B9B58:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18940 (legacy spawn) 2025-07-21 21:56:58.899829 :B52B9B59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:56:58.900005 :B52B9B5F:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:56:58.900787 :B52B9B63:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:56:58.909509 :B52B9B66:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:56:58.894 2025-07-21 21:56:58.909511 :B52B9B67:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11720 pso_num=22 pso_serial#=206 2025-07-21 21:56:58.909654 :B52B9B68:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11720 (legacy spawn) 2025-07-21 21:56:58.916110 :B52B9B74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:56:58.916277 :B52B9B7D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:56:58.917076 :B52B9B7E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:57:00.253985 :B52B9C29:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:57:00.248 2025-07-21 21:57:00.253987 :B52B9C2A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18856 pso_num=22 pso_serial#=207 2025-07-21 21:57:00.254127 :B52B9C2B:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18856 osp_idx=0 osp_ver=431484 osp_pg=0 (spawn #409147) 2025-07-21 21:57:00.254128 :B52B9C2C:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-21 21:57:00.254128 :B52B9C2D:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=152 time=1815796142 2025-07-21 21:57:00.254128 :B52B9C2E:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-21 21:57:00.254129 :B52B9C2F:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-21 21:57:00.254129 :B52B9C30:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-21 21:57:00.254129 :B52B9C31:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-21 21:57:00.254130 :B52B9C32:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-21 21:57:00.254623 :B52B9C33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-21 21:57:00.255261 :B52B9C48:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:00.262830 :B52B9C64:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-07-21 21:57:00.263218 :B52B9C65:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:00.263254 :B52B9C68:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-07-21 21:57:00.264105 :B52B9C6E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:00.264229 :B52B9C77:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:57:30.314750 :B52BA6FD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:57:35.204934 :B52BA860:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:57:35.194 2025-07-21 21:57:35.204936 :B52BA861:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19312 pso_num=22 pso_serial#=208 2025-07-21 21:57:35.205068 :B52BA862:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19312 (legacy spawn) 2025-07-21 21:57:35.211498 :B52BA863:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:35.211682 :B52BA868:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:57:35.212508 :B52BA86D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:57:35.221280 :B52BA870:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:57:35.210 2025-07-21 21:57:35.221281 :B52BA871:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8568 pso_num=22 pso_serial#=209 2025-07-21 21:57:35.221413 :B52BA872:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=8568 (legacy spawn) 2025-07-21 21:57:35.227928 :B52BA873:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:35.228097 :B52BA87C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:57:35.228886 :B52BA87D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:57:38.389357 :B52BA9C7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:57:38.376 2025-07-21 21:57:38.389359 :B52BA9C8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11488 pso_num=22 pso_serial#=210 2025-07-21 21:57:38.389500 :B52BA9C9:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11488 (legacy spawn) 2025-07-21 21:57:38.396227 :B52BA9CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:38.396413 :B52BA9CF:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:57:38.397212 :B52BA9D4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:57:38.406128 :B52BA9D7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:57:38.392 2025-07-21 21:57:38.406130 :B52BA9D8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7184 pso_num=22 pso_serial#=211 2025-07-21 21:57:38.406316 :B52BA9D9:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=7184 (legacy spawn) 2025-07-21 21:57:38.412881 :B52BA9DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:38.413052 :B52BA9E3:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:57:38.413916 :B52BA9E4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:57:44.639413 :B52BABE0:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:57:44.626 2025-07-21 21:57:44.639416 :B52BABE1:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=2648 pso_num=22 pso_serial#=212 2025-07-21 21:57:44.639555 :B52BABE2:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=2648 (legacy spawn) 2025-07-21 21:57:44.645986 :B52BABE3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:44.646177 :B52BABE8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:57:44.646980 :B52BABED:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:57:52.039627 :B52BAE12:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:57:52.031 2025-07-21 21:57:52.039629 :B52BAE13:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8336 pso_num=22 pso_serial#=213 2025-07-21 21:57:52.039762 :B52BAE14:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=8336 (legacy spawn) 2025-07-21 21:57:52.066691 :B52BAE15:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:57:52.066869 :B52BAE1D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:57:52.067670 :B52BAE1F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:00.305646 :B52BB0EB:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:00.300 2025-07-21 21:58:00.305648 :B52BB0EC:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18964 pso_num=22 pso_serial#=214 2025-07-21 21:58:00.305787 :B52BB0ED:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=18964 osp_idx=0 osp_ver=431491 osp_pg=0 (spawn #409150) 2025-07-21 21:58:00.305788 :B52BB0EE:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-21 21:58:00.305788 :B52BB0EF:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=153 time=1815856204 2025-07-21 21:58:00.305789 :B52BB0F0:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-21 21:58:00.305789 :B52BB0F1:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-21 21:58:00.305789 :B52BB0F2:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-21 21:58:00.305789 :B52BB0F3:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-21 21:58:00.305789 :B52BB0F4:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-21 21:58:00.306316 :B52BB0F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-21 21:58:00.306995 :B52BB10A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:00.318121 :B52BB127:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-21 21:58:00.318657 :B52BB128:db_trace:kwqid.c@2146:kwqidrdq(): [10960:22:177] kwqidrdq: Error: 1403 occured in OCI execute 2025-07-21 21:58:00.321036 :B52BB129:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-07-21 21:58:00.321380 :B52BB12A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:00.321416 :B52BB12D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-07-21 21:58:00.322292 :B52BB133:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:00.322425 :B52BB13C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:30.422492 :B52BBB71:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:47.906223 :B52BC119:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:47.894 2025-07-21 21:58:47.906226 :B52BC11A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=11772 pso_num=22 pso_serial#=215 2025-07-21 21:58:47.906367 :B52BC11B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=11772 (legacy spawn) 2025-07-21 21:58:47.912844 :B52BC11C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:47.913015 :B52BC121:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:47.913832 :B52BC126:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:47.922499 :B52BC129:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:47.910 2025-07-21 21:58:47.922501 :B52BC12A:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18100 pso_num=22 pso_serial#=216 2025-07-21 21:58:47.922632 :B52BC12B:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18100 (legacy spawn) 2025-07-21 21:58:47.929071 :B52BC12C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:47.929235 :B52BC135:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:47.930051 :B52BC136:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:50.974237 :B52BC230:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:50.961 2025-07-21 21:58:50.974239 :B52BC231:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19444 pso_num=22 pso_serial#=217 2025-07-21 21:58:50.974374 :B52BC232:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19444 (legacy spawn) 2025-07-21 21:58:50.980845 :B52BC233:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:50.981010 :B52BC238:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:50.981793 :B52BC23D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:50.990438 :B52BC240:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:50.977 2025-07-21 21:58:50.990440 :B52BC241:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18832 pso_num=22 pso_serial#=218 2025-07-21 21:58:50.990579 :B52BC242:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18832 (legacy spawn) 2025-07-21 21:58:51.009503 :B52BC243:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:51.009681 :B52BC24C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:51.010528 :B52BC24D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:52.761965 :B52BC29D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:52.752 2025-07-21 21:58:52.761967 :B52BC29E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17752 pso_num=22 pso_serial#=219 2025-07-21 21:58:52.762155 :B52BC29F:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=17752 (legacy spawn) 2025-07-21 21:58:52.768579 :B52BC2A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:52.768748 :B52BC2A5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:52.769583 :B52BC2AA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:54.261077 :B52BC355:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:54.252 2025-07-21 21:58:54.261078 :B52BC356:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19240 pso_num=22 pso_serial#=220 2025-07-21 21:58:54.261225 :B52BC357:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19240 (legacy spawn) 2025-07-21 21:58:54.267623 :B52BC358:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:54.267791 :B52BC35E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:54.268644 :B52BC362:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:58:56.151054 :B52BC3DB:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:58:56.143 2025-07-21 21:58:56.151056 :B52BC3DC:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19152 pso_num=22 pso_serial#=221 2025-07-21 21:58:56.151194 :B52BC3DD:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19152 (legacy spawn) 2025-07-21 21:58:56.157601 :B52BC3DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:58:56.157777 :B52BC3E4:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:58:56.158658 :B52BC3F3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:59:00.412757 :B52BC56D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:59:00.407 2025-07-21 21:59:00.412759 :B52BC56E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=19028 pso_num=22 pso_serial#=222 2025-07-21 21:59:00.412902 :B52BC56F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=19028 osp_idx=0 osp_ver=431499 osp_pg=0 (spawn #409152) 2025-07-21 21:59:00.412903 :B52BC570:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-21 21:59:00.412903 :B52BC571:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=154 time=1815916314 2025-07-21 21:59:00.412904 :B52BC572:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-21 21:59:00.412904 :B52BC573:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-21 21:59:00.412904 :B52BC574:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-21 21:59:00.412905 :B52BC575:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-21 21:59:00.412905 :B52BC576:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-21 21:59:00.413393 :B52BC577:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-21 21:59:00.414043 :B52BC58C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:59:00.421659 :B52BC5A8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-07-21 21:59:00.422022 :B52BC5A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:59:00.422062 :B52BC5AC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-07-21 21:59:00.422894 :B52BC5B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:59:00.423007 :B52BC5BB:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:59:25.455662 :B52BCDAA:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-21 21:59:55.559936 :B52BD7A8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 21:59:56.427509 :B52BD80B:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 21:59:56.419 2025-07-21 21:59:56.427511 :B52BD80C:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=16012 pso_num=22 pso_serial#=223 2025-07-21 21:59:56.427660 :B52BD80D:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=16012 (legacy spawn) 2025-07-21 21:59:56.454540 :B52BD819:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-21 21:59:56.454713 :B52BD81E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-21 21:59:56.455571 :B52BD823:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-07-21 22:00:00.016319 :B52BD970:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 07-21 22:00:00.009 2025-07-21 22:00:00.016321 :B52BD971:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15216 pso_num=22 pso_serial#=224 2025-07-21 22:00:00.016433 :B52BD972:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15216 osp_idx=0 osp_ver=431501 osp_pg=0 (spawn #409154) 2025-07-21 22:00:00.016433 :B52BD973:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-21 22:00:00.016434 :B52BD974:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=155 time=1815975908 2025-07-21 22:00:00.016434 :B52BD975:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-07-21 22:00:00.016435 :B52BD976:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-07-21 22:00:00.016435 :B52BD977:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-07-21 22:00:00.016436 :B52BD978:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-21 22:00:00.016436 :B52BD979:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-21 22:00:00.016506 :B52BD97A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-21 22:00:00.016514 :B52BD97B:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:22:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 15216, VKRM)