Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250911220008\orcl_vkrm_19536_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:34853M/63366M, Ph+PgF:39561M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 19536, image: ORACLE.EXE (VKRM) *** 2025-09-11 22:00:08.490 *** SESSION ID:(209.32527) 2025-09-11 22:00:08.490 *** 2025-09-11 22:00:08.490 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=19536, pid: 26, proc_ser: 96, sid: 209, sess_ser: 32527 ------------------------------------------------------------------------------- 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.473499 sec, exc=8.473499 sec, total=8.473499 sec wait times: max=infinite, heur=8.473499 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 209 serial 32527 --------------------------------------------------- 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.016000 sec (max dump time=30.000000 sec) *** 2025-09-11 22:00:08.506 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 19536, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-11 21:57:35.620248 :CC2413F5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:57:35.612 2025-09-11 21:57:35.620251 :CC2413F6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24872 pso_num=26 pso_serial#=72 2025-09-11 21:57:35.620389 :CC2413F7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24872 (legacy spawn) 2025-09-11 21:57:35.626903 :CC2413F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:57:35.627076 :CC241401:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:57:35.627904 :CC241402:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:57:47.293034 :CC24180B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:57:47.282 2025-09-11 21:57:47.293037 :CC24180C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10444 pso_num=26 pso_serial#=73 2025-09-11 21:57:47.293219 :CC24180D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10444 (legacy spawn) 2025-09-11 21:57:47.300054 :CC24180E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:57:47.300086 :CC241811:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:57:47.300235 :CC241817:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:57:47.301215 :CC241825:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:57:47.309954 :CC241828:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:57:47.298 2025-09-11 21:57:47.309956 :CC241829:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25200 pso_num=26 pso_serial#=74 2025-09-11 21:57:47.310100 :CC24182A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=25200 (legacy spawn) 2025-09-11 21:57:47.316649 :CC24182B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:57:47.316823 :CC241831:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:57:47.317635 :CC241835:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:57:50.481736 :CC24192C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:57:50.469 2025-09-11 21:57:50.481738 :CC24192D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25596 pso_num=26 pso_serial#=75 2025-09-11 21:57:50.481883 :CC24192E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=25596 (legacy spawn) 2025-09-11 21:57:50.488407 :CC24192F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:57:50.488578 :CC241934:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:57:50.489390 :CC241939:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:57:50.508547 :CC24193C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:57:50.500 2025-09-11 21:57:50.508549 :CC24193D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23264 pso_num=26 pso_serial#=76 2025-09-11 21:57:50.508694 :CC24193E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23264 (legacy spawn) 2025-09-11 21:57:50.515127 :CC24193F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:57:50.515376 :CC241947:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:57:50.518293 :CC241949:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:57:56.319658 :CC241BA2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:57:56.310 2025-09-11 21:57:56.319660 :CC241BA3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20488 pso_num=26 pso_serial#=77 2025-09-11 21:57:56.319807 :CC241BA4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20488 (legacy spawn) 2025-09-11 21:57:56.326877 :CC241BA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:57:56.327051 :CC241BAE:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:57:56.327931 :CC241BAF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:23.628594 :CC24245A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:23.621 2025-09-11 21:58:23.628597 :CC24245B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23792 pso_num=26 pso_serial#=78 2025-09-11 21:58:23.628742 :CC24245C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23792 (legacy spawn) 2025-09-11 21:58:23.635206 :CC24245D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:23.635401 :CC242465:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:23.636310 :CC242467:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:23.645244 :CC24246A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:23.636 2025-09-11 21:58:23.645246 :CC24246B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25492 pso_num=26 pso_serial#=79 2025-09-11 21:58:23.645385 :CC24246C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=25492 (legacy spawn) 2025-09-11 21:58:23.652053 :CC24246D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:23.652223 :CC242476:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:23.653154 :CC242477:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:26.722144 :CC242569:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:26.709 2025-09-11 21:58:26.722146 :CC24256A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20640 pso_num=26 pso_serial#=80 2025-09-11 21:58:26.722295 :CC24256B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=20640 (legacy spawn) 2025-09-11 21:58:26.728875 :CC24256C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:26.729046 :CC242571:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:26.729843 :CC242576:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:26.748401 :CC242579:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:26.748 2025-09-11 21:58:26.748404 :CC24257A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25212 pso_num=26 pso_serial#=81 2025-09-11 21:58:26.748543 :CC24257B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=25212 (legacy spawn) 2025-09-11 21:58:26.755059 :CC24257C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:26.755228 :CC242585:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:26.756007 :CC242586:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:30.335736 :CC24269D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:30.327 2025-09-11 21:58:30.335738 :CC24269E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16164 pso_num=26 pso_serial#=82 2025-09-11 21:58:30.335875 :CC24269F:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16164 (legacy spawn) 2025-09-11 21:58:30.342415 :CC2426A0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:30.342605 :CC2426A5:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:30.343404 :CC2426AA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:37.813278 :CC24292B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:37.805 2025-09-11 21:58:37.813280 :CC24292C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25356 pso_num=26 pso_serial#=83 2025-09-11 21:58:37.813417 :CC24292D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=25356 (legacy spawn) 2025-09-11 21:58:37.819980 :CC24292E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:37.820149 :CC242933:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:37.820990 :CC242938:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:59.878535 :CC242FA7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:59.864 2025-09-11 21:58:59.878537 :CC242FA8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=18376 pso_num=26 pso_serial#=84 2025-09-11 21:58:59.878675 :CC242FA9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=18376 (legacy spawn) 2025-09-11 21:58:59.899845 :CC242FAA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:59.900022 :CC242FAF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:59.900806 :CC242FB4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:58:59.909487 :CC242FB7:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:58:59.895 2025-09-11 21:58:59.909489 :CC242FB8:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25316 pso_num=26 pso_serial#=85 2025-09-11 21:58:59.909623 :CC242FB9:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=25316 (legacy spawn) 2025-09-11 21:58:59.916182 :CC242FBA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:58:59.916346 :CC242FC3:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:58:59.917144 :CC242FC4:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:00.338753 :CC243002:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:00.333 2025-09-11 21:59:00.338755 :CC243003:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24960 pso_num=26 pso_serial#=86 2025-09-11 21:59:00.338896 :CC243004:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=24960 osp_idx=24 osp_ver=833436 osp_pg=0 (spawn #582496) 2025-09-11 21:59:00.338897 :CC243005:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 21:59:00.338897 :CC243006:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=186 time=2013591643 2025-09-11 21:59:00.338898 :CC243007:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 21:59:00.338898 :CC243008:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 21:59:00.338898 :CC243009:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 21:59:00.338899 :CC24300A:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 21:59:00.338899 :CC24300B:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 21:59:00.339413 :CC24300C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 21:59:00.339456 :CC243012:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-11 21:59:00.343517 :CC243033:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-09-11 21:59:00.343556 :CC243034:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-09-11 21:59:00.343817 :CC243035:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-09-11 21:59:00.343834 :CC243036:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-09-11 21:59:00.344045 :CC243037:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-09-11 21:59:00.344058 :CC243038:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-09-11 21:59:00.344267 :CC243039:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-09-11 21:59:00.344279 :CC24303A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-09-11 21:59:00.344480 :CC24303B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-09-11 21:59:00.344492 :CC24303C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-09-11 21:59:00.344696 :CC24303D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-09-11 21:59:00.344708 :CC24303E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-09-11 21:59:00.347170 :CC24303F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:02.981889 :CC243120:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:02.968 2025-09-11 21:59:02.981891 :CC243121:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22608 pso_num=26 pso_serial#=87 2025-09-11 21:59:02.982034 :CC243122:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=22608 (legacy spawn) 2025-09-11 21:59:02.988708 :CC243123:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:02.988889 :CC243129:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:02.989699 :CC24312D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:02.998964 :CC243130:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:02.984 2025-09-11 21:59:02.998966 :CC243131:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24820 pso_num=26 pso_serial#=88 2025-09-11 21:59:02.999107 :CC243132:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24820 (legacy spawn) 2025-09-11 21:59:03.005932 :CC243133:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:03.006102 :CC24313C:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:03.006988 :CC24313D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:04.518557 :CC2431E6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:04.509 2025-09-11 21:59:04.518559 :CC2431E7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19060 pso_num=26 pso_serial#=89 2025-09-11 21:59:04.518708 :CC2431E8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=19060 (legacy spawn) 2025-09-11 21:59:04.525204 :CC2431E9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:04.525376 :CC2431EE:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:04.526173 :CC2431F3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:36.099681 :CC243BC2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:36.096 2025-09-11 21:59:36.099683 :CC243BC3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23872 pso_num=26 pso_serial#=90 2025-09-11 21:59:36.099821 :CC243BC4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23872 (legacy spawn) 2025-09-11 21:59:36.106318 :CC243BC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:36.106482 :CC243BCA:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:36.107319 :CC243BCF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:36.135689 :CC243BD2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:36.127 2025-09-11 21:59:36.135691 :CC243BD3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23796 pso_num=26 pso_serial#=91 2025-09-11 21:59:36.135834 :CC243BD4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=23796 (legacy spawn) 2025-09-11 21:59:36.142321 :CC243BD5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:36.142485 :CC243BDE:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:36.143336 :CC243BDF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:38.615125 :CC243CB3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:38.606 2025-09-11 21:59:38.615128 :CC243CB4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24992 pso_num=26 pso_serial#=92 2025-09-11 21:59:38.615269 :CC243CB5:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24992 (legacy spawn) 2025-09-11 21:59:38.621806 :CC243CB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:38.621971 :CC243CBF:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:38.622767 :CC243CC0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:39.181850 :CC243CCF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:39.169 2025-09-11 21:59:39.181852 :CC243CD0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24520 pso_num=26 pso_serial#=93 2025-09-11 21:59:39.181998 :CC243CD1:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24520 (legacy spawn) 2025-09-11 21:59:39.188522 :CC243CD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:39.188691 :CC243CDB:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:39.189494 :CC243CDC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:39.198225 :CC243CDF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:39.184 2025-09-11 21:59:39.198228 :CC243CE0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24916 pso_num=26 pso_serial#=94 2025-09-11 21:59:39.198364 :CC243CE1:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=24916 (legacy spawn) 2025-09-11 21:59:39.204832 :CC243CE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:39.204996 :CC243CEB:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:39.205778 :CC243CEC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 21:59:40.036958 :CC243DBF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 21:59:40.028 2025-09-11 21:59:40.036961 :CC243DC0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25252 pso_num=26 pso_serial#=95 2025-09-11 21:59:40.037120 :CC243DC1:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=25252 (legacy spawn) 2025-09-11 21:59:40.044256 :CC243DC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 21:59:40.044445 :CC243DC7:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] 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-09-11 21:59:40.045446 :CC243DCC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-11 22:00:00.030063 :CC2443C2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-11 22:00:00.022 2025-09-11 22:00:00.030065 :CC2443C3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=19536 pso_num=26 pso_serial#=96 2025-09-11 22:00:00.030178 :CC2443C4:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=19536 osp_idx=24 osp_ver=833446 osp_pg=0 (spawn #582499) 2025-09-11 22:00:00.030179 :CC2443C5:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-11 22:00:00.030179 :CC2443C6:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=187 time=2013651330 2025-09-11 22:00:00.030180 :CC2443C7:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-11 22:00:00.030180 :CC2443C8:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-11 22:00:00.030181 :CC2443C9:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-11 22:00:00.030181 :CC2443CA:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-11 22:00:00.030181 :CC2443CB:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-11 22:00:00.030253 :CC2443CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:0] KSL POST SENT postee=6 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-11 22:00:00.030259 :CC2443CD:db_trace:kso.c@5554:kso_spawn_diag_end(): [10420:26:0] kso: spawn diagnostics: init time=0 secs ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 19536, VKRM)