Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250615220925\orcl_vkrm_15492_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:36633M/63366M, Ph+PgF:43105M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 15492, image: ORACLE.EXE (VKRM) *** 2025-06-15 22:09:26.013 *** SESSION ID:(209.46009) 2025-06-15 22:09:26.013 *** 2025-06-15 22:09:26.013 Process diagnostic dump for ORACLE.EXE (VKRM), OS id=15492, pid: 26, proc_ser: 3, sid: 209, sess_ser: 46009 ------------------------------------------------------------------------------- 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=969 min 26 sec, exc=969 min 26 sec, total=969 min 26 sec wait times: max=infinite, heur=969 min 26 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 46009 --------------------------------------------------- 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 --------------------------------------------------- [121 samples, 22:07:26 - 22:09:26] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-15 22:09:26.013 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 15492, VKRM) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-15 05:56:56.565563 :A4E39750:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:56:57.392472 :A4E397DF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:56:57.378 2025-06-15 05:56:57.392474 :A4E397E0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13500 pso_num=26 pso_serial#=234 2025-06-15 05:56:57.392614 :A4E397E1:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13500 (legacy spawn) 2025-06-15 05:56:57.399167 :A4E397E2: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-06-15 05:56:57.399361 :A4E397E7: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-06-15 05:56:57.400207 :A4E397EC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:56:57.408990 :A4E397EF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:56:57.394 2025-06-15 05:56:57.408992 :A4E397F0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14720 pso_num=26 pso_serial#=235 2025-06-15 05:56:57.409128 :A4E397F1:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=14720 (legacy spawn) 2025-06-15 05:56:57.426581 :A4E397F2: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-06-15 05:56:57.426753 :A4E397FB: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-06-15 05:56:57.427626 :A4E397FC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:57:00.588754 :A4E398F2:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:57:00.576 2025-06-15 05:57:00.588756 :A4E398F3:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17212 pso_num=26 pso_serial#=236 2025-06-15 05:57:00.588940 :A4E398F4:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17212 (legacy spawn) 2025-06-15 05:57:00.595335 :A4E398F5: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-06-15 05:57:00.595514 :A4E398FA: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-06-15 05:57:00.596347 :A4E398FF:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:57:00.604926 :A4E39902:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:57:00.591 2025-06-15 05:57:00.604928 :A4E39903:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15364 pso_num=26 pso_serial#=237 2025-06-15 05:57:00.605096 :A4E39904:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15364 (legacy spawn) 2025-06-15 05:57:00.611586 :A4E39905: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-06-15 05:57:00.611757 :A4E3990E: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-06-15 05:57:00.612564 :A4E3990F:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:57:02.671969 :A4E3997E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:57:02.664 2025-06-15 05:57:02.671971 :A4E3997F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=7776 pso_num=26 pso_serial#=238 2025-06-15 05:57:02.672108 :A4E39980:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=7776 (legacy spawn) 2025-06-15 05:57:02.678598 :A4E39981: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-06-15 05:57:02.678774 :A4E3998A: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-06-15 05:57:02.679627 :A4E3998B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:57:04.739893 :A4E39A2A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:57:04.731 2025-06-15 05:57:04.739895 :A4E39A2B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16436 pso_num=26 pso_serial#=239 2025-06-15 05:57:04.740045 :A4E39A2C:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16436 (legacy spawn) 2025-06-15 05:57:04.746802 :A4E39A2D: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-06-15 05:57:04.746981 :A4E39A32: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-06-15 05:57:04.747901 :A4E39A37:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:57:21.429695 :A4E39F97:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:57:21.424 2025-06-15 05:57:21.429698 :A4E39F98:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16832 pso_num=26 pso_serial#=240 2025-06-15 05:57:21.429836 :A4E39F99:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=16832 osp_idx=24 osp_ver=447510 osp_pg=0 (spawn #286929) 2025-06-15 05:57:21.429837 :A4E39F9A:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-15 05:57:21.429837 :A4E39F9B:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=89 time=2942784625 2025-06-15 05:57:21.429838 :A4E39F9C:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-15 05:57:21.429838 :A4E39F9D:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-15 05:57:21.429838 :A4E39F9E:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-15 05:57:21.429839 :A4E39F9F:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-15 05:57:21.429839 :A4E39FA0:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-15 05:57:21.430342 :A4E39FA1: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-06-15 05:57:21.430391 :A4E39FA7: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-06-15 05:57:21.434416 :A4E39FC0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-15 05:57:21.434460 :A4E39FC1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-15 05:57:21.434716 :A4E39FC2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-15 05:57:21.434733 :A4E39FC3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-15 05:57:21.434939 :A4E39FC4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-15 05:57:21.434952 :A4E39FC5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-15 05:57:21.435163 :A4E39FC6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-15 05:57:21.435176 :A4E39FC7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-15 05:57:21.435376 :A4E39FC8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-15 05:57:21.435388 :A4E39FC9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-15 05:57:21.435589 :A4E39FCA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-15 05:57:21.435602 :A4E39FCB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-15 05:57:21.437915 :A4E39FCC:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:04.834372 :A4E3ADE5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:04.826 2025-06-15 05:58:04.834376 :A4E3ADE6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15480 pso_num=26 pso_serial#=241 2025-06-15 05:58:04.834509 :A4E3ADE7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15480 (legacy spawn) 2025-06-15 05:58:04.840897 :A4E3ADE8: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-06-15 05:58:04.841060 :A4E3ADED: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-06-15 05:58:04.841875 :A4E3ADF2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:09.688090 :A4E3AFB9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:09.674 2025-06-15 05:58:09.688092 :A4E3AFBA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16104 pso_num=26 pso_serial#=242 2025-06-15 05:58:09.688228 :A4E3AFBB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16104 (legacy spawn) 2025-06-15 05:58:09.694869 :A4E3AFBC: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-06-15 05:58:09.695051 :A4E3AFC4: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-06-15 05:58:09.695836 :A4E3AFC6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:09.714717 :A4E3AFC9:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:09.705 2025-06-15 05:58:09.714720 :A4E3AFCA:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12796 pso_num=26 pso_serial#=243 2025-06-15 05:58:09.714856 :A4E3AFCB:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12796 (legacy spawn) 2025-06-15 05:58:09.721594 :A4E3AFCC: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-06-15 05:58:09.721755 :A4E3AFD5: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-06-15 05:58:09.722720 :A4E3AFD6:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:09.970185 :A4E3AFE5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:09.955 2025-06-15 05:58:09.970187 :A4E3AFE6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12232 pso_num=26 pso_serial#=244 2025-06-15 05:58:09.970320 :A4E3AFE7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=12232 (legacy spawn) 2025-06-15 05:58:09.976945 :A4E3AFE8: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-06-15 05:58:09.977116 :A4E3AFED: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-06-15 05:58:09.977928 :A4E3AFF2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:09.986912 :A4E3AFF5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:09.971 2025-06-15 05:58:09.986914 :A4E3AFF6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10376 pso_num=26 pso_serial#=245 2025-06-15 05:58:09.987063 :A4E3AFF7:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=10376 (legacy spawn) 2025-06-15 05:58:09.993760 :A4E3AFF8: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-06-15 05:58:09.993936 :A4E3B001: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-06-15 05:58:09.994781 :A4E3B002:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:13.355305 :A4E3B0F0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:13.355 2025-06-15 05:58:13.355307 :A4E3B0F1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16388 pso_num=26 pso_serial#=246 2025-06-15 05:58:13.355449 :A4E3B0F2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16388 (legacy spawn) 2025-06-15 05:58:13.362032 :A4E3B0F3: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-06-15 05:58:13.362200 :A4E3B0F8: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-06-15 05:58:13.362972 :A4E3B0FD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:13.365415 :A4E3B100:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:13.355 2025-06-15 05:58:13.365416 :A4E3B101:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13532 pso_num=26 pso_serial#=247 2025-06-15 05:58:13.365545 :A4E3B102:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13532 (legacy spawn) 2025-06-15 05:58:13.390361 :A4E3B103: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-06-15 05:58:13.390525 :A4E3B109: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-06-15 05:58:13.391387 :A4E3B10C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:58:13.402059 :A4E3B10F:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:58:13.402 2025-06-15 05:58:13.402061 :A4E3B110:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16928 pso_num=26 pso_serial#=248 2025-06-15 05:58:13.402198 :A4E3B111:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16928 (legacy spawn) 2025-06-15 05:58:13.408667 :A4E3B112: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-06-15 05:58:13.408845 :A4E3B11B: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-06-15 05:58:13.409700 :A4E3B11C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:22.295044 :A4E3C70B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:22.281 2025-06-15 05:59:22.295046 :A4E3C70C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15704 pso_num=26 pso_serial#=249 2025-06-15 05:59:22.295186 :A4E3C70D:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15704 (legacy spawn) 2025-06-15 05:59:22.301628 :A4E3C70E: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-06-15 05:59:22.301804 :A4E3C713: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-06-15 05:59:22.302604 :A4E3C718:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:22.889718 :A4E3C728:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:22.875 2025-06-15 05:59:22.889719 :A4E3C729:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=11088 pso_num=26 pso_serial#=250 2025-06-15 05:59:22.889858 :A4E3C72A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=11088 (legacy spawn) 2025-06-15 05:59:22.896321 :A4E3C72B: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-06-15 05:59:22.896495 :A4E3C734: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-06-15 05:59:22.897266 :A4E3C735:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:22.905843 :A4E3C738:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:22.891 2025-06-15 05:59:22.905845 :A4E3C739:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17080 pso_num=26 pso_serial#=251 2025-06-15 05:59:22.905989 :A4E3C73A:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17080 (legacy spawn) 2025-06-15 05:59:22.912390 :A4E3C73B: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-06-15 05:59:22.912571 :A4E3C744: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-06-15 05:59:22.913394 :A4E3C745:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:26.021321 :A4E3C829:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:26.008 2025-06-15 05:59:26.021324 :A4E3C82A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16212 pso_num=26 pso_serial#=252 2025-06-15 05:59:26.021463 :A4E3C82B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16212 (legacy spawn) 2025-06-15 05:59:26.028166 :A4E3C82C: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-06-15 05:59:26.028342 :A4E3C831: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-06-15 05:59:26.029143 :A4E3C836:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:26.037653 :A4E3C839:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:26.024 2025-06-15 05:59:26.037654 :A4E3C83A:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16176 pso_num=26 pso_serial#=253 2025-06-15 05:59:26.037791 :A4E3C83B:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16176 (legacy spawn) 2025-06-15 05:59:26.044254 :A4E3C83C: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-06-15 05:59:26.044418 :A4E3C845: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-06-15 05:59:26.045211 :A4E3C846:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:38.080097 :A4E3CBF0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:38.071 2025-06-15 05:59:38.080100 :A4E3CBF1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=17196 pso_num=26 pso_serial#=254 2025-06-15 05:59:38.080249 :A4E3CBF2:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=17196 (legacy spawn) 2025-06-15 05:59:38.086983 :A4E3CBF3: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-06-15 05:59:38.087174 :A4E3CBF8: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-06-15 05:59:38.088042 :A4E3CBFD:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:56.236194 :A4E3D201:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:56.227 2025-06-15 05:59:56.236196 :A4E3D202:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=16740 pso_num=26 pso_serial#=255 2025-06-15 05:59:56.236339 :A4E3D203:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=16740 (legacy spawn) 2025-06-15 05:59:56.242743 :A4E3D204: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-06-15 05:59:56.242931 :A4E3D209: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-06-15 05:59:56.243721 :A4E3D20E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:59.220908 :A4E3D37E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:59.213 2025-06-15 05:59:59.220910 :A4E3D37F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13948 pso_num=26 pso_serial#=1 2025-06-15 05:59:59.221044 :A4E3D380:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=13948 (legacy spawn) 2025-06-15 05:59:59.227446 :A4E3D381: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-06-15 05:59:59.227641 :A4E3D386: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-06-15 05:59:59.228428 :A4E3D38B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 05:59:59.237838 :A4E3D38E:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 05:59:59.229 2025-06-15 05:59:59.237840 :A4E3D38F:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15712 pso_num=26 pso_serial#=2 2025-06-15 05:59:59.237981 :A4E3D390:db_trace:kso.c@4070:ksonfy(): [10420:26:0] kso: new process: pid=15712 (legacy spawn) 2025-06-15 05:59:59.244414 :A4E3D391: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-06-15 05:59:59.244592 :A4E3D39A: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-06-15 05:59:59.245399 :A4E3D39B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-15 06:00:00.017265 :A4E3D3F3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-15 06:00:00.010 2025-06-15 06:00:00.017268 :A4E3D3F4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=15492 pso_num=26 pso_serial#=3 2025-06-15 06:00:00.017376 :A4E3D3F5:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=15492 osp_idx=24 osp_ver=447528 osp_pg=0 (spawn #286936) 2025-06-15 06:00:00.017377 :A4E3D3F6:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3656 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-15 06:00:00.017377 :A4E3D3F7:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=90 time=2942943204 2025-06-15 06:00:00.017377 :A4E3D3F8:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-15 06:00:00.017378 :A4E3D3F9:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-15 06:00:00.017378 :A4E3D3FA:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-15 06:00:00.017378 :A4E3D3FB:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-15 06:00:00.017379 :A4E3D3FC:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-15 06:00:00.017450 :A4E3D3FD: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-06-15 06:00:00.017457 :A4E3D3FE: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: 15492, VKRM)