Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250630220006\orcl_vkrm_1216_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:36708M/63366M, Ph+PgF:42768M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 1216, image: ORACLE.EXE (VKRM) *** 2025-06-30 22:00:06.082 *** SESSION ID:(193.19267) 2025-06-30 22:00:06.082 *** 2025-06-30 22:00:06.082 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=1216, pid: 24, proc_ser: 137, sid: 193, sess_ser: 19267 ------------------------------------------------------------------------------- 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=6.067599 sec, exc=6.067599 sec, total=6.067599 sec wait times: max=infinite, heur=6.067599 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 193 serial 19267 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 22:00:00 - 22:00:06] 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-06-30 22:00:06.082 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 1216, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-30 21:56:57.138339 :ABD31459:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13920 pso_num=24 pso_serial#=115 2025-06-30 21:56:57.138470 :ABD3145A:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13920 (legacy spawn) 2025-06-30 21:56:57.144850 :ABD3145B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:56:57.145020 :ABD31461:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:56:57.145845 :ABD31465:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:57:06.299884 :ABD31723:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:57:06.294 2025-06-30 21:57:06.299886 :ABD31724:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9284 pso_num=24 pso_serial#=116 2025-06-30 21:57:06.300024 :ABD31725:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9284 osp_idx=22 osp_ver=492786 osp_pg=0 (spawn #339164) 2025-06-30 21:57:06.300024 :ABD31726:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 21:57:06.300025 :ABD31727:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=214 time=1402189 2025-06-30 21:57:06.300025 :ABD31728:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 21:57:06.300026 :ABD31729:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 21:57:06.300026 :ABD3172A:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 21:57:06.300026 :ABD3172B:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 21:57:06.300027 :ABD3172C:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 21:57:06.300516 :ABD3172D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 21:57:06.301158 :ABD31742:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:57:06.308643 :ABD3175E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-30 21:57:06.309004 :ABD3175F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:57:06.309037 :ABD31762:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-30 21:57:06.309870 :ABD31768:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:57:06.309991 :ABD31770:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:57:36.412288 :ABD3216B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:57:43.795403 :ABD3235A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:57:43.787 2025-06-30 21:57:43.795405 :ABD3235B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15356 pso_num=24 pso_serial#=117 2025-06-30 21:57:43.795545 :ABD3235C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15356 (legacy spawn) 2025-06-30 21:57:43.802008 :ABD3235D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:57:43.802178 :ABD32362:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:57:43.803008 :ABD32367:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:01.026984 :ABD328EE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:01.024 2025-06-30 21:58:01.026986 :ABD328EF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14552 pso_num=24 pso_serial#=118 2025-06-30 21:58:01.027124 :ABD328F0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14552 (legacy spawn) 2025-06-30 21:58:01.033499 :ABD328F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:01.033680 :ABD328F6:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:01.034475 :ABD328FB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:01.043047 :ABD328FE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:01.040 2025-06-30 21:58:01.043048 :ABD328FF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17920 pso_num=24 pso_serial#=119 2025-06-30 21:58:01.043183 :ABD32900:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17920 (legacy spawn) 2025-06-30 21:58:01.049537 :ABD32901:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:01.049706 :ABD3290A:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:01.050528 :ABD3290B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:04.290674 :ABD32A07:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:04.277 2025-06-30 21:58:04.290676 :ABD32A08:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13572 pso_num=24 pso_serial#=120 2025-06-30 21:58:04.290816 :ABD32A09:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13572 (legacy spawn) 2025-06-30 21:58:04.297325 :ABD32A0A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:04.297500 :ABD32A0F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:04.298317 :ABD32A14:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:04.306922 :ABD32A17:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:04.293 2025-06-30 21:58:04.306925 :ABD32A18:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17140 pso_num=24 pso_serial#=121 2025-06-30 21:58:04.307058 :ABD32A19:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17140 (legacy spawn) 2025-06-30 21:58:04.313493 :ABD32A1A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:04.313667 :ABD32A23:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:04.314472 :ABD32A24:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:05.333629 :ABD32A33:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:05.324 2025-06-30 21:58:05.333631 :ABD32A34:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11012 pso_num=24 pso_serial#=122 2025-06-30 21:58:05.333778 :ABD32A35:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11012 (legacy spawn) 2025-06-30 21:58:05.357461 :ABD32A36:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:05.357634 :ABD32A3F:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:05.358473 :ABD32A40:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:06.393308 :ABD32B26:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:06.387 2025-06-30 21:58:06.393310 :ABD32B27:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18084 pso_num=24 pso_serial#=123 2025-06-30 21:58:06.393455 :ABD32B28:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=18084 osp_idx=22 osp_ver=492793 osp_pg=0 (spawn #339166) 2025-06-30 21:58:06.393455 :ABD32B29:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 21:58:06.393456 :ABD32B2A:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=215 time=1462283 2025-06-30 21:58:06.393456 :ABD32B2B:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 21:58:06.393457 :ABD32B2C:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 21:58:06.393457 :ABD32B2D:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 21:58:06.393457 :ABD32B2E:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 21:58:06.393458 :ABD32B2F:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 21:58:06.393964 :ABD32B30:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 21:58:06.394623 :ABD32B45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:06.405622 :ABD32B61:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-30 21:58:06.406079 :ABD32B62:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-30 21:58:06.408351 :ABD32B63:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-30 21:58:06.408669 :ABD32B64:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:06.408704 :ABD32B67:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-30 21:58:06.409632 :ABD32B6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:06.409764 :ABD32B76:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:36.526242 :ABD33481:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:37.383627 :ABD33490:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:37.369 2025-06-30 21:58:37.383629 :ABD33491:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17352 pso_num=24 pso_serial#=124 2025-06-30 21:58:37.383764 :ABD33492:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17352 (legacy spawn) 2025-06-30 21:58:37.390136 :ABD33493:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:37.390312 :ABD33498:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:37.391138 :ABD3349D:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:37.399735 :ABD334A0:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:37.385 2025-06-30 21:58:37.399737 :ABD334A1:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9904 pso_num=24 pso_serial#=125 2025-06-30 21:58:37.399901 :ABD334A2:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9904 (legacy spawn) 2025-06-30 21:58:37.419413 :ABD334A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:37.419577 :ABD334AC:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:37.420497 :ABD334AD:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:39.538905 :ABD3357E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:39.530 2025-06-30 21:58:39.538907 :ABD3357F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4280 pso_num=24 pso_serial#=126 2025-06-30 21:58:39.539043 :ABD33580:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=4280 (legacy spawn) 2025-06-30 21:58:39.545486 :ABD33581:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:39.545669 :ABD33586:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:39.546454 :ABD3358B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:40.697797 :ABD3359A:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:40.684 2025-06-30 21:58:40.697799 :ABD3359B:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9732 pso_num=24 pso_serial#=127 2025-06-30 21:58:40.697948 :ABD3359C:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9732 (legacy spawn) 2025-06-30 21:58:40.704910 :ABD3359D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:40.705089 :ABD335A6:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:40.705959 :ABD335A7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:40.724298 :ABD335AA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:40.715 2025-06-30 21:58:40.724300 :ABD335AB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11072 pso_num=24 pso_serial#=128 2025-06-30 21:58:40.724467 :ABD335AC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=11072 (legacy spawn) 2025-06-30 21:58:40.731570 :ABD335AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:40.731764 :ABD335B4:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:40.732686 :ABD335B7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:58:45.995701 :ABD33776:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:58:45.987 2025-06-30 21:58:45.995703 :ABD33777:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15900 pso_num=24 pso_serial#=129 2025-06-30 21:58:45.995842 :ABD33778:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15900 (legacy spawn) 2025-06-30 21:58:46.002377 :ABD33779:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:58:46.002560 :ABD3377E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:58:46.003366 :ABD33783:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:59:06.490233 :ABD33E0E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:59:06.484 2025-06-30 21:59:06.490235 :ABD33E0F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=6020 pso_num=24 pso_serial#=130 2025-06-30 21:59:06.490371 :ABD33E10:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=6020 osp_idx=22 osp_ver=492800 osp_pg=0 (spawn #339168) 2025-06-30 21:59:06.490371 :ABD33E11:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 21:59:06.490372 :ABD33E12:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=216 time=1522376 2025-06-30 21:59:06.490372 :ABD33E13:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 21:59:06.490372 :ABD33E14:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 21:59:06.490373 :ABD33E15:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 21:59:06.490373 :ABD33E16:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 21:59:06.490373 :ABD33E17:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 21:59:06.490856 :ABD33E18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 21:59:06.491520 :ABD33E2D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:06.498989 :ABD33E49:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-30 21:59:06.499339 :ABD33E4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:06.499375 :ABD33E4D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-30 21:59:06.500306 :ABD33E53:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:06.500449 :ABD33E5B:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:59:36.597657 :ABD34810:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:59:47.641388 :ABD34AEE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:59:47.632 2025-06-30 21:59:47.641390 :ABD34AEF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8884 pso_num=24 pso_serial#=131 2025-06-30 21:59:47.641526 :ABD34AF0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=8884 (legacy spawn) 2025-06-30 21:59:47.648033 :ABD34AF1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:47.648204 :ABD34AF6:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:59:47.649001 :ABD34AFB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:59:48.156901 :ABD34B9B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:59:48.148 2025-06-30 21:59:48.156903 :ABD34B9C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=8692 pso_num=24 pso_serial#=132 2025-06-30 21:59:48.157039 :ABD34B9D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=8692 (legacy spawn) 2025-06-30 21:59:48.163539 :ABD34B9E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:48.163708 :ABD34BA7:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:59:48.164685 :ABD34BA8:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:59:50.093284 :ABD34BDF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:59:50.079 2025-06-30 21:59:50.093286 :ABD34BE0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16620 pso_num=24 pso_serial#=133 2025-06-30 21:59:50.093422 :ABD34BE1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16620 (legacy spawn) 2025-06-30 21:59:50.099875 :ABD34BE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:50.100046 :ABD34BE7:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:59:50.100847 :ABD34BEC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:59:50.109524 :ABD34BEF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:59:50.094 2025-06-30 21:59:50.109526 :ABD34BF0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=18132 pso_num=24 pso_serial#=134 2025-06-30 21:59:50.109668 :ABD34BF1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=18132 (legacy spawn) 2025-06-30 21:59:50.116174 :ABD34C00:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:50.116344 :ABD34C09:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:59:50.117176 :ABD34C0A:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:59:53.310662 :ABD34D02:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:59:53.297 2025-06-30 21:59:53.310665 :ABD34D03:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14232 pso_num=24 pso_serial#=135 2025-06-30 21:59:53.310841 :ABD34D04:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14232 (legacy spawn) 2025-06-30 21:59:53.318147 :ABD34D05:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:53.318316 :ABD34D0A:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:59:53.318985 :ABD34D0F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 21:59:53.327123 :ABD34D12:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 21:59:53.313 2025-06-30 21:59:53.327125 :ABD34D13:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14788 pso_num=24 pso_serial#=136 2025-06-30 21:59:53.327256 :ABD34D14:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14788 (legacy spawn) 2025-06-30 21:59:53.334046 :ABD34D15:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-30 21:59:53.334205 :ABD34D1E:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-06-30 21:59:53.335028 :ABD34D1F:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-30 22:00:00.027026 :ABD34F84:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-30 22:00:00.020 2025-06-30 22:00:00.027028 :ABD34F85:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=1216 pso_num=24 pso_serial#=137 2025-06-30 22:00:00.027133 :ABD34F86:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=1216 osp_idx=22 osp_ver=492807 osp_pg=0 (spawn #339170) 2025-06-30 22:00:00.027134 :ABD34F87:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-30 22:00:00.027134 :ABD34F88:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=217 time=1575923 2025-06-30 22:00:00.027135 :ABD34F89:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-30 22:00:00.027135 :ABD34F8A:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-30 22:00:00.027135 :ABD34F8B:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-30 22:00:00.027136 :ABD34F8C:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-30 22:00:00.027137 :ABD34F8D:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-30 22:00:00.027204 :ABD34F8E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-30 22:00:00.027209 :ABD34F8F:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:24:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 1216, VKRM)