Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250915220005\orcl_m000_24872_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:34716M/63366M, Ph+PgF:39306M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 32 Windows thread id: 24872, image: ORACLE.EXE (M000) *** 2025-09-15 22:00:05.255 *** SESSION ID:(2.2884) 2025-09-15 22:00:05.255 *** 2025-09-15 22:00:05.255 Process diagnostic dump for ORACLE.EXE (M000), OS id=24872, pid: 32, proc_ser: 245, sid: 2, sess_ser: 2884 ------------------------------------------------------------------------------- current sql: Current Wait Stack: Not in wait; last wait ended 0.718139 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.718163 sec since last wait 0: waited for 'control file sequential read' file#=0x0, block#=0x20, blocks=0x1 wait_id=77 seq_num=78 snap_id=1 wait times: snap=0.000066 sec, exc=0.000066 sec, total=0.000066 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000006 sec of elapsed time 1: waited for 'control file sequential read' file#=0x0, block#=0x11, blocks=0x1 wait_id=76 seq_num=77 snap_id=1 wait times: snap=0.000045 sec, exc=0.000045 sec, total=0.000045 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 2: waited for 'control file sequential read' file#=0x0, block#=0xf, blocks=0x1 wait_id=75 seq_num=76 snap_id=1 wait times: snap=0.000084 sec, exc=0.000084 sec, total=0.000084 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000014 sec of elapsed time 3: waited for 'control file sequential read' file#=0x0, block#=0x1, blocks=0x1 wait_id=74 seq_num=75 snap_id=1 wait times: snap=0.000132 sec, exc=0.000132 sec, total=0.000132 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.003814 sec of elapsed time 4: waited for 'control file sequential read' file#=0x0, block#=0x13f, blocks=0x1 wait_id=73 seq_num=74 snap_id=1 wait times: snap=0.000057 sec, exc=0.000057 sec, total=0.000057 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 5: waited for 'control file sequential read' file#=0x0, block#=0x11, blocks=0x1 wait_id=72 seq_num=73 snap_id=1 wait times: snap=0.000056 sec, exc=0.000056 sec, total=0.000056 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 6: waited for 'control file sequential read' file#=0x0, block#=0xf, blocks=0x1 wait_id=71 seq_num=72 snap_id=1 wait times: snap=0.000051 sec, exc=0.000051 sec, total=0.000051 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 7: waited for 'control file sequential read' file#=0x0, block#=0x1, blocks=0x1 wait_id=70 seq_num=71 snap_id=1 wait times: snap=0.000046 sec, exc=0.000046 sec, total=0.000046 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000030 sec of elapsed time 8: waited for 'control file sequential read' file#=0x0, block#=0x3, blocks=0x1 wait_id=69 seq_num=70 snap_id=1 wait times: snap=0.000374 sec, exc=0.000374 sec, total=0.000374 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000022 sec of elapsed time 9: waited for 'control file sequential read' file#=0x0, block#=0x13, blocks=0x1 wait_id=68 seq_num=69 snap_id=1 wait times: snap=0.000044 sec, exc=0.000044 sec, total=0.000044 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time Sampled Session History of session 2 serial 2884 --------------------------------------------------- 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 --------------------------------------------------- [1 sample, 22:00:05] not in wait at each sample [1 sample, 22:00:04] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-15 22:00:05.255 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 32 (osid: 24872, M000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-10 00:06:20.509379 :CB4D5474:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 22:00:05.218303 :CBB40295:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 22:00:05.215 2025-09-10 22:00:05.218305 :CBB40296:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24084 pso_num=32 pso_serial#=221 2025-09-10 22:00:05.218447 :CBB40297:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24084 (legacy spawn) 2025-09-10 22:00:05.224913 :CBB40298:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:05.225097 :CBB4029D:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-10 22:00:05.225908 :CBB402A2:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 22:00:05.234677 :CBB402A5:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 22:00:05.231 2025-09-10 22:00:05.234679 :CBB402A6:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=19576 pso_num=32 pso_serial#=222 2025-09-10 22:00:05.234816 :CBB402A7:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=19576 (legacy spawn) 2025-09-10 22:00:05.241302 :CBB402A8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:05.241472 :CBB402B0:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-10 22:00:05.242266 :CBB402B1:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 22:00:09.261673 :CBB40568:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 22:00:09.256 2025-09-10 22:00:09.261675 :CBB40569:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=18376 pso_num=32 pso_serial#=223 2025-09-10 22:00:09.261819 :CBB4056A:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=18376 osp_idx=30 osp_ver=987 osp_pg=0 (spawn #579170) 2025-09-10 22:00:09.261820 :CBB4056B:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-10 22:00:09.261820 :CBB4056C:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=188 time=1927260565 2025-09-10 22:00:09.261821 :CBB4056D:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-09-10 22:00:09.261821 :CBB4056E:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-09-10 22:00:09.261821 :CBB4056F:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-09-10 22:00:09.261822 :CBB40570:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-10 22:00:09.261822 :CBB40571:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-10 22:00:09.262368 :CBB40572:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.262412 :CBB40578:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-10 22:00:09.267218 :CBB4058B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.293491 :CBB40593:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.309098 :CBB4059B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.345677 :CBB405A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.350041 :CBB405AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.354253 :CBB405B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.358944 :CBB405BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:09.360285 :CBB405C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:10.596120 :CBB40727:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:10.654173 :CBB4072F:db_trace:ktu.c@4871:ktuaex1r(): [10442:32:2] Extension usn 8, ext 1, nex 2 2025-09-10 22:00:10.654181 :CBB40730:db_trace:ktusm.c@2117:ktusmasp(): [10445:32:2] des1:tsn:1 rdba:0x0080fe0a where: kdiwh22: kdifind 2025-09-10 22:00:10.667925 :CBB40731:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:10.668258 :CBB40739:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:10.668537 :CBB40741:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:10.668553 :CBB40744:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 22:00:10.668614 :CBB40750:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-10 22:00:10.672139 :CBB4075E:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 23:59:14.748596 :CBBD6A93:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 23:59:14.742 2025-09-10 23:59:14.748598 :CBBD6A94:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=7692 pso_num=32 pso_serial#=224 2025-09-10 23:59:14.748737 :CBBD6A95:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=7692 (legacy spawn) 2025-09-10 23:59:14.762953 :CBBD6A96:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 23:59:47.896490 :CBBD76B3:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 23:59:50.296057 :CBBD779B:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 23:59:50.284 2025-09-10 23:59:50.296059 :CBBD779C:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24312 pso_num=32 pso_serial#=225 2025-09-10 23:59:50.296207 :CBBD779D:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24312 (legacy spawn) 2025-09-10 23:59:50.310070 :CBBD779E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 23:59:53.556875 :CBBD789A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 23:59:53.557050 :CBBD789F:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-10 23:59:53.558343 :CBBD78A4:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 23:59:54.251540 :CBBD7911:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 23:59:54.239 2025-09-10 23:59:54.251543 :CBBD7912:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24028 pso_num=32 pso_serial#=226 2025-09-10 23:59:54.251706 :CBBD7913:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24028 (legacy spawn) 2025-09-10 23:59:54.259747 :CBBD7914:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 23:59:54.259980 :CBBD791A:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-10 23:59:54.261034 :CBBD791E:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 23:59:54.435461 :CBBD7940:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 23:59:54.427 2025-09-10 23:59:54.435464 :CBBD7941:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=23392 pso_num=32 pso_serial#=227 2025-09-10 23:59:54.435605 :CBBD7942:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=23392 (legacy spawn) 2025-09-10 23:59:54.450175 :CBBD7943:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 23:59:58.088640 :CBBD7A74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-10 23:59:58.088819 :CBBD7A79:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-10 23:59:58.090064 :CBBD7A7E:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-10 23:59:58.867203 :CBBD7A98:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-10 23:59:58.867 2025-09-10 23:59:58.867205 :CBBD7A99:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=22788 pso_num=32 pso_serial#=228 2025-09-10 23:59:58.867377 :CBBD7A9A:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=22788 (legacy spawn) 2025-09-10 23:59:58.882466 :CBBD7A9B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 00:06:18.854005 :CBBE04E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 00:06:18.854162 :CBBE04EC:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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 00:06:18.855521 :CBBE04ED:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-11 23:59:14.270153 :CC2DA0AA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-11 23:59:14.259 2025-09-11 23:59:14.270155 :CC2DA0AB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24760 pso_num=32 pso_serial#=229 2025-09-11 23:59:14.270292 :CC2DA0AC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24760 (legacy spawn) 2025-09-11 23:59:14.285146 :CC2DA0AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-11 23:59:47.429600 :CC2DACDE:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-11 23:59:48.535589 :CC2DADCC:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-11 23:59:48.535 2025-09-11 23:59:48.535590 :CC2DADCF:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=23792 pso_num=32 pso_serial#=230 2025-09-11 23:59:48.535725 :CC2DADE5:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=23792 (legacy spawn) 2025-09-11 23:59:48.549606 :CC2DADF1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-12 00:00:21.540930 :CC2DB9FF:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-12 22:00:01.803629 :CC94A3B8:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-12 22:00:01.790 2025-09-12 22:00:01.803631 :CC94A3B9:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=22464 pso_num=32 pso_serial#=231 2025-09-12 22:00:01.803770 :CC94A3BA:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=22464 (legacy spawn) 2025-09-12 22:00:01.824076 :CC94A3BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-12 22:00:01.824251 :CC94A3C3:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-12 22:00:01.825028 :CC94A3C5:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-12 22:00:01.833881 :CC94A3C8:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-12 22:00:01.821 2025-09-12 22:00:01.833883 :CC94A3C9:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=25148 pso_num=32 pso_serial#=232 2025-09-12 22:00:01.834036 :CC94A3CA:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=25148 (legacy spawn) 2025-09-12 22:00:01.840727 :CC94A3CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-12 22:00:01.840871 :CC94A3D2:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-12 22:00:01.841706 :CC94A3D5:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-12 22:00:06.257310 :CC94A900:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-12 22:00:06.248 2025-09-12 22:00:06.257312 :CC94A901:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24364 pso_num=32 pso_serial#=233 2025-09-12 22:00:06.257463 :CC94A902:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24364 (legacy spawn) 2025-09-12 22:00:06.264495 :CC94A903:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-12 22:00:06.264679 :CC94A90B:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-12 22:00:06.265580 :CC94A90D:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-12 23:59:14.798940 :CC9E1A2C:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-12 23:59:14.792 2025-09-12 23:59:14.798942 :CC9E1A2D:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=25048 pso_num=32 pso_serial#=234 2025-09-12 23:59:14.799079 :CC9E1A2E:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=25048 (legacy spawn) 2025-09-12 23:59:14.813540 :CC9E1A2F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-12 23:59:47.828462 :CC9E2660:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-12 23:59:48.015194 :CC9E2663:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-12 23:59:48.013 2025-09-12 23:59:48.015197 :CC9E2664:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=22932 pso_num=32 pso_serial#=235 2025-09-12 23:59:48.015378 :CC9E2665:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=22932 (legacy spawn) 2025-09-12 23:59:48.029631 :CC9E2666:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-13 00:00:21.557274 :CC9E33A9:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-13 06:00:05.621902 :CCBAFCCA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-13 06:00:05.614 2025-09-13 06:00:05.621904 :CCBAFCCB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24028 pso_num=32 pso_serial#=236 2025-09-13 06:00:05.622099 :CCBAFCCC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24028 (legacy spawn) 2025-09-13 06:00:05.628595 :CCBAFCCD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-13 06:00:05.628773 :CCBAFCD6:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-13 06:00:05.629628 :CCBAFCD7:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-13 06:00:07.803434 :CCBAFE05:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-13 06:00:07.789 2025-09-13 06:00:07.803435 :CCBAFE06:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=22804 pso_num=32 pso_serial#=237 2025-09-13 06:00:07.803572 :CCBAFE07:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=22804 (legacy spawn) 2025-09-13 06:00:07.810143 :CCBAFE08:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-13 06:00:07.810314 :CCBAFE0D:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-13 06:00:07.811098 :CCBAFE12:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-13 06:00:07.819913 :CCBAFE15:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-13 06:00:07.820 2025-09-13 06:00:07.819915 :CCBAFE16:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24936 pso_num=32 pso_serial#=238 2025-09-13 06:00:07.820060 :CCBAFE17:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24936 (legacy spawn) 2025-09-13 06:00:07.826737 :CCBAFE18:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-13 06:00:07.826892 :CCBAFE21:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-13 06:00:07.827703 :CCBAFE22:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-13 23:59:13.946806 :CD10C0DA:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-13 23:59:13.945 2025-09-13 23:59:13.946808 :CD10C0DB:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=25272 pso_num=32 pso_serial#=239 2025-09-13 23:59:13.946955 :CD10C0DC:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=25272 (legacy spawn) 2025-09-13 23:59:13.961559 :CD10C0DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-13 23:59:47.184802 :CD10CCAF:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-13 23:59:47.736085 :CD10CCFC:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-13 23:59:47.728 2025-09-13 23:59:47.736087 :CD10CCFD:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24964 pso_num=32 pso_serial#=240 2025-09-13 23:59:47.736229 :CD10CCFE:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24964 (legacy spawn) 2025-09-13 23:59:47.750608 :CD10CCFF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-14 00:00:21.273207 :CD10DA0D:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-14 23:59:13.797441 :CD828B52:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-14 23:59:13.796 2025-09-14 23:59:13.797443 :CD828B53:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=25312 pso_num=32 pso_serial#=241 2025-09-14 23:59:13.797581 :CD828B54:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=25312 (legacy spawn) 2025-09-14 23:59:13.812700 :CD828B55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-14 23:59:47.095719 :CD829749:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-14 23:59:54.736292 :CD8299F2:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-14 23:59:54.727 2025-09-14 23:59:54.736295 :CD8299F3:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=20372 pso_num=32 pso_serial#=242 2025-09-14 23:59:54.736444 :CD8299F4:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=20372 (legacy spawn) 2025-09-14 23:59:54.751346 :CD8299F5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 00:00:28.094463 :CD82A8CF:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-15 22:00:01.316920 :CDEB28C5:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-15 22:00:01.313 2025-09-15 22:00:01.316921 :CDEB28C6:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24236 pso_num=32 pso_serial#=243 2025-09-15 22:00:01.317053 :CDEB28C7:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=24236 (legacy spawn) 2025-09-15 22:00:01.323537 :CDEB28D0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:01.323673 :CDEB28D9:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-15 22:00:01.324554 :CDEB28DA:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-15 22:00:01.333531 :CDEB28E5:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-15 22:00:01.329 2025-09-15 22:00:01.333533 :CDEB28E6:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=25548 pso_num=32 pso_serial#=244 2025-09-15 22:00:01.333664 :CDEB28E7:db_trace:kso.c@4070:ksonfy(): [10420:32:0] kso: new process: pid=25548 (legacy spawn) 2025-09-15 22:00:01.345836 :CDEB290B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:01.345962 :CDEB2914:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-15 22:00:01.346949 :CDEB291D:db_trace:kst.c@698:kstpsodel(): [10280:32:0] kst: process state object about to be deleted 2025-09-15 22:00:04.359236 :CDEB2D52:db_trace:kst.c@673:kstipg(): [10280:32:0] kst: process state object created on 09-15 22:00:04.354 2025-09-15 22:00:04.359238 :CDEB2D53:db_trace:kst.c@679:kstipg(): [10280:32:0] kst: process info: ospid=24872 pso_num=32 pso_serial#=245 2025-09-15 22:00:04.359374 :CDEB2D54:db_trace:kso.c@4093:ksonfy(): [10420:32:0] kso: new process: pid=24872 osp_idx=30 osp_ver=1009 osp_pg=0 (spawn #595850) 2025-09-15 22:00:04.359375 :CDEB2D55:db_trace:kso.c@4099:ksonfy(): [10420:32:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 22:00:04.359376 :CDEB2D56:db_trace:kso.c@4103:ksonfy(): [10420:32:0] kso: new process: pso_index=32 reservation=189 time=2359255658 2025-09-15 22:00:04.359376 :CDEB2D57:db_trace:kso.c@4109:ksonfy(): [10420:32:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 22:00:04.359376 :CDEB2D58:db_trace:kso.c@4111:ksonfy(): [10420:32:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 22:00:04.359377 :CDEB2D59:db_trace:kso.c@4113:ksonfy(): [10420:32:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 22:00:04.359377 :CDEB2D5A:db_trace:kso.c@4115:ksonfy(): [10420:32:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 22:00:04.359377 :CDEB2D5B:db_trace:kso.c@4117:ksonfy(): [10420:32:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 22:00:04.359872 :CDEB2D5C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.359921 :CDEB2D62:db_trace:ksl2.c@12699:ksliwat(): [10005:32:2] 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-15 22:00:04.364348 :CDEB2D75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.387628 :CDEB2D80:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.403229 :CDEB2D98:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.443602 :CDEB2DBE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.451155 :CDEB2DC6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.455219 :CDEB2DCE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.459932 :CDEB2DD6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-15 22:00:04.461022 :CDEB2DDE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:32:2] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 32 (osid: 24872, M000)