Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250506220006\orcl_vkrm_10024_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:37457M/63366M, Ph+PgF:44928M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 10024, image: ORACLE.EXE (VKRM) *** 2025-05-06 22:00:06.756 *** SESSION ID:(209.53105) 2025-05-06 22:00:06.756 *** 2025-05-06 22:00:06.756 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=10024, pid: 26, proc_ser: 90, sid: 209, sess_ser: 53105 ------------------------------------------------------------------------------- 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.687824 sec, exc=6.687824 sec, total=6.687824 sec wait times: max=infinite, heur=6.687824 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 53105 --------------------------------------------------- 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-05-06 22:00:06.756 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 10024, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-06 21:56:10.017212 :93A04B6A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:56:10.003 2025-05-06 21:56:10.017214 :93A04B6B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11864 pso_num=26 pso_serial#=66 2025-05-06 21:56:10.017347 :93A04B6C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11864 (legacy spawn) 2025-05-06 21:56:10.023770 :93A04B6D: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-05-06 21:56:10.023943 :93A04B76: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-05-06 21:56:10.024724 :93A04B77:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:56:10.052260 :93A04B7A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:56:10.044 2025-05-06 21:56:10.052263 :93A04B7B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12104 pso_num=26 pso_serial#=67 2025-05-06 21:56:10.052399 :93A04B7C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12104 (legacy spawn) 2025-05-06 21:56:10.058847 :93A04B7D: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-05-06 21:56:10.059010 :93A04B86: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-05-06 21:56:10.059825 :93A04B87:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:56:12.655271 :93A04C30:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:56:12.642 2025-05-06 21:56:12.655274 :93A04C31:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10868 pso_num=26 pso_serial#=68 2025-05-06 21:56:12.655458 :93A04C32:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10868 (legacy spawn) 2025-05-06 21:56:12.661911 :93A04C33: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-05-06 21:56:12.662079 :93A04C3C: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-05-06 21:56:12.662932 :93A04C3D:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:56:13.109402 :93A04C79:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:56:13.096 2025-05-06 21:56:13.109404 :93A04C7A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10856 pso_num=26 pso_serial#=69 2025-05-06 21:56:13.109538 :93A04C7B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10856 (legacy spawn) 2025-05-06 21:56:13.116003 :93A04C7C: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-05-06 21:56:13.116169 :93A04C82: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-05-06 21:56:13.116994 :93A04C86:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:56:13.125563 :93A04C89:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:56:13.111 2025-05-06 21:56:13.125565 :93A04C8A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11928 pso_num=26 pso_serial#=70 2025-05-06 21:56:13.125703 :93A04C8B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11928 (legacy spawn) 2025-05-06 21:56:13.132147 :93A04C8C: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-05-06 21:56:13.132315 :93A04C93: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-05-06 21:56:13.133104 :93A04C96:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:56:14.870686 :93A04D44:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:56:14.861 2025-05-06 21:56:14.870688 :93A04D45:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9636 pso_num=26 pso_serial#=71 2025-05-06 21:56:14.870821 :93A04D46:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9636 (legacy spawn) 2025-05-06 21:56:14.877258 :93A04D47: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-05-06 21:56:14.877288 :93A04D4A: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-05-06 21:56:14.877430 :93A04D4D: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-05-06 21:56:14.878287 :93A04D5E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:57:14.850124 :93A06081:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:57:14.837 2025-05-06 21:57:14.850126 :93A06082:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11428 pso_num=26 pso_serial#=72 2025-05-06 21:57:14.850265 :93A06083:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11428 (legacy spawn) 2025-05-06 21:57:14.871468 :93A06084: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-05-06 21:57:14.871666 :93A06089: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-05-06 21:57:14.872466 :93A0608E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:57:51.595461 :93A06C3E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:57:51.587 2025-05-06 21:57:51.595463 :93A06C3F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11696 pso_num=26 pso_serial#=73 2025-05-06 21:57:51.595592 :93A06C40:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11696 (legacy spawn) 2025-05-06 21:57:51.601994 :93A06C41: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-05-06 21:57:51.602233 :93A06C58: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-05-06 21:57:51.603004 :93A06C59:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:57:57.192443 :93A06E18:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:57:57.183 2025-05-06 21:57:57.192445 :93A06E19:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10520 pso_num=26 pso_serial#=74 2025-05-06 21:57:57.192587 :93A06E1A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10520 (legacy spawn) 2025-05-06 21:57:57.199059 :93A06E1B: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-05-06 21:57:57.199241 :93A06E20: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-05-06 21:57:57.200053 :93A06E25:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:57:58.760123 :93A06EEE:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:57:58.745 2025-05-06 21:57:58.760125 :93A06EEF:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10972 pso_num=26 pso_serial#=75 2025-05-06 21:57:58.760264 :93A06EF0:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10972 (legacy spawn) 2025-05-06 21:57:58.770352 :93A06EF1: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-05-06 21:57:58.770558 :93A06EF6: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-05-06 21:57:58.771212 :93A06EFB:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:57:58.781892 :93A06EFE:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:57:58.777 2025-05-06 21:57:58.781894 :93A06EFF:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11808 pso_num=26 pso_serial#=76 2025-05-06 21:57:58.782033 :93A06F00:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11808 (legacy spawn) 2025-05-06 21:57:58.788424 :93A06F01: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-05-06 21:57:58.788581 :93A06F07: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-05-06 21:57:58.789373 :93A06F0B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:58:02.014378 :93A06FF6:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:58:02.001 2025-05-06 21:58:02.014380 :93A06FF7:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7552 pso_num=26 pso_serial#=77 2025-05-06 21:58:02.014521 :93A06FF8:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=7552 (legacy spawn) 2025-05-06 21:58:02.033595 :93A06FF9: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-05-06 21:58:02.033775 :93A06FFE: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-05-06 21:58:02.034665 :93A07003:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:58:02.043650 :93A07006:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:58:02.032 2025-05-06 21:58:02.043652 :93A07007:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8792 pso_num=26 pso_serial#=78 2025-05-06 21:58:02.043789 :93A07008:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8792 (legacy spawn) 2025-05-06 21:58:02.050351 :93A07015: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-05-06 21:58:02.050516 :93A0701E: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-05-06 21:58:02.051386 :93A0701F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:58:17.086702 :93A0748C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:58:17.074 2025-05-06 21:58:17.086704 :93A0748D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9116 pso_num=26 pso_serial#=79 2025-05-06 21:58:17.086842 :93A0748E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9116 (legacy spawn) 2025-05-06 21:58:17.093374 :93A0748F: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-05-06 21:58:17.093558 :93A07494: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-05-06 21:58:17.094405 :93A07499:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:58:58.754641 :93A082F1:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:58:58.749 2025-05-06 21:58:58.754643 :93A082F2:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11644 pso_num=26 pso_serial#=80 2025-05-06 21:58:58.754781 :93A082F3:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=11644 osp_idx=24 osp_ver=222184 osp_pg=0 (spawn #155503) 2025-05-06 21:58:58.754782 :93A082F4:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-06 21:58:58.754782 :93A082F5:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=73 time=3839515921 2025-05-06 21:58:58.754782 :93A082F6:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-06 21:58:58.754783 :93A082F7:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-06 21:58:58.754784 :93A082F8:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-06 21:58:58.754784 :93A082F9:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-06 21:58:58.754784 :93A082FA:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-06 21:58:58.755287 :93A082FB: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-05-06 21:58:58.755333 :93A08301: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-05-06 21:58:58.759458 :93A08329:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-06 21:58:58.759499 :93A0832A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-06 21:58:58.759752 :93A0832B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-06 21:58:58.759767 :93A0832C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-06 21:58:58.759974 :93A0832D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-06 21:58:58.759987 :93A0832E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-06 21:58:58.760189 :93A0832F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-06 21:58:58.760202 :93A08330:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-06 21:58:58.760401 :93A08331:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-06 21:58:58.760414 :93A08332:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-06 21:58:58.760630 :93A08333:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-05-06 21:58:58.760649 :93A08334:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-05-06 21:58:58.762916 :93A08335:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:05.460352 :93A08543:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:05.451 2025-05-06 21:59:05.460354 :93A08544:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10068 pso_num=26 pso_serial#=81 2025-05-06 21:59:05.460498 :93A08545:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10068 (legacy spawn) 2025-05-06 21:59:05.466898 :93A08546: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-05-06 21:59:05.467087 :93A08556: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-05-06 21:59:05.467880 :93A0855B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:11.524802 :93A0872C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:11.521 2025-05-06 21:59:11.524805 :93A0872D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10928 pso_num=26 pso_serial#=82 2025-05-06 21:59:11.524939 :93A0872E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10928 (legacy spawn) 2025-05-06 21:59:11.531291 :93A0872F: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-05-06 21:59:11.531473 :93A08737: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-05-06 21:59:11.532277 :93A08739:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:11.540973 :93A0873C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:11.537 2025-05-06 21:59:11.540975 :93A0873D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10124 pso_num=26 pso_serial#=83 2025-05-06 21:59:11.541107 :93A0873E:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10124 (legacy spawn) 2025-05-06 21:59:11.547511 :93A0873F: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-05-06 21:59:11.547676 :93A08748: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-05-06 21:59:11.548466 :93A08749:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:14.613719 :93A08823:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:14.601 2025-05-06 21:59:14.613721 :93A08824:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9168 pso_num=26 pso_serial#=84 2025-05-06 21:59:14.613854 :93A08825:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=9168 (legacy spawn) 2025-05-06 21:59:14.636115 :93A08826: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-05-06 21:59:14.636293 :93A0882C: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-05-06 21:59:14.637122 :93A08830:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:14.645734 :93A08833:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:14.632 2025-05-06 21:59:14.645736 :93A08834:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8228 pso_num=26 pso_serial#=85 2025-05-06 21:59:14.645868 :93A08835:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8228 (legacy spawn) 2025-05-06 21:59:14.653367 :93A08836: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-05-06 21:59:14.653544 :93A0883F: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-05-06 21:59:14.654230 :93A08840:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:19.287832 :93A08955:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:19.280 2025-05-06 21:59:19.287834 :93A08956:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11352 pso_num=26 pso_serial#=86 2025-05-06 21:59:19.287973 :93A08957:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11352 (legacy spawn) 2025-05-06 21:59:19.294379 :93A08958: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-05-06 21:59:19.294570 :93A08961: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-05-06 21:59:19.295414 :93A08962:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:50.389931 :93A093CD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:50.381 2025-05-06 21:59:50.389933 :93A093CE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=6976 pso_num=26 pso_serial#=87 2025-05-06 21:59:50.390074 :93A093CF:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=6976 (legacy spawn) 2025-05-06 21:59:50.396480 :93A093D0: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-05-06 21:59:50.396648 :93A093D8: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-05-06 21:59:50.397464 :93A093DA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:51.116935 :93A093F8:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:51.103 2025-05-06 21:59:51.116938 :93A093F9:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10624 pso_num=26 pso_serial#=88 2025-05-06 21:59:51.117077 :93A093FA:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10624 (legacy spawn) 2025-05-06 21:59:51.123708 :93A093FB: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-05-06 21:59:51.123877 :93A09404: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-05-06 21:59:51.124744 :93A09405:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 21:59:51.472615 :93A09414:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 21:59:51.463 2025-05-06 21:59:51.472617 :93A09415:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8140 pso_num=26 pso_serial#=89 2025-05-06 21:59:51.472751 :93A09416:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=8140 (legacy spawn) 2025-05-06 21:59:51.479173 :93A09417: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-05-06 21:59:51.479336 :93A09420: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-05-06 21:59:51.480120 :93A09421:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-05-06 22:00:00.074994 :93A09721:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 05-06 22:00:00.068 2025-05-06 22:00:00.074996 :93A09722:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10024 pso_num=26 pso_serial#=90 2025-05-06 22:00:00.075105 :93A09723:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10024 osp_idx=24 osp_ver=222194 osp_pg=0 (spawn #155506) 2025-05-06 22:00:00.075106 :93A09724:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-06 22:00:00.075107 :93A09725:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=74 time=3839577234 2025-05-06 22:00:00.075107 :93A09726:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-05-06 22:00:00.075108 :93A09727:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-05-06 22:00:00.075108 :93A09728:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-05-06 22:00:00.075108 :93A09729:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-06 22:00:00.075109 :93A0972A:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-06 22:00:00.075187 :93A0972B: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-05-06 22:00:00.075195 :93A0972C: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: 10024, VKRM)