Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250818220006\orcl_w000_22072_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:35398M/63366M, Ph+PgF:40639M/72582M 
Instance name: orcl
Redo thread mounted by this instance: 1
Oracle process number: 25
Windows thread id: 22072, image: ORACLE.EXE (W000)


*** 2025-08-18 22:00:06.714
*** SESSION ID:(201.16063) 2025-08-18 22:00:06.714
 

*** 2025-08-18 22:00:06.714
Process diagnostic dump for ORACLE.EXE (W000), OS id=22072,
pid: 25, proc_ser: 107, sid: 201, sess_ser: 16063 
-------------------------------------------------------------------------------
current sql: <none>
Current Wait Stack:
 0: waiting for 'Space Manager: slave idle wait'
    Slave ID=0x0, =0x0, =0x0
    wait_id=2 seq_num=3 snap_id=1
    wait times: snap=2.927402 sec, exc=2.927402 sec, total=2.927402 sec
    wait times: max=5.000000 sec, heur=7.930805 sec
    wait counts: calls=1 os=1
    in_wait=1 iflags=0x5a8
Wait State:
  fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1
Session Wait History:
    elapsed time of 0.000020 sec since current wait
 0: waited for 'Space Manager: slave idle wait'
    Slave ID=0x0, =0x0, =0x0
    wait_id=1 seq_num=2 snap_id=1
    wait times: snap=5.003383 sec, exc=5.003383 sec, total=5.003383 sec
    wait times: max=5.000000 sec
    wait counts: calls=1 os=1
    occurred after 0.004051 sec of elapsed time
 1: waited for 'class slave wait'
    slave id=0x11f4f6a0, =0x0, =0x0
    wait_id=0 seq_num=1 snap_id=1
    wait times: snap=0.000038 sec, exc=0.000038 sec, total=0.000038 sec
    wait times: max=infinite
    wait counts: calls=1 os=1
    occurred after 0.000000 sec of elapsed time
Sampled Session History of session 201 serial 16063
---------------------------------------------------
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
---------------------------------------------------
  [8 samples,                                              21:59:58 - 22:00:06]
    idle wait at each sample
  [session created at: 21:59:58]
-------------------------------------------------------------------------------
Process diagnostic dump actual duration=0.000000 sec
  (max dump time=30.000000 sec)

*** 2025-08-18 22:00:06.714
 
-------------------------------------------------------------------------------
Trace Bucket Dump Begin: default bucket for process 25 (osid: 22072, W000)
TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA
-------------------------------------------------------------------------------
2025-08-18 19:29:39.042510 :C180DA33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 19:29:39.042559 :C180DA3C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 19:39:40.029553 :C181A0A6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 19:39:40.487485 :C181A0FD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 19:39:40.482
2025-08-18 19:39:40.487487 :C181A0FE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19144 pso_num=25 pso_serial#=94
2025-08-18 19:39:40.487627 :C181A0FF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19144 osp_idx=23 osp_ver=245261 osp_pg=0 (spawn #502165)
2025-08-18 19:39:40.487628 :C181A100:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 19:39:40.487628 :C181A101:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=81 time=4226649798
2025-08-18 19:39:40.487629 :C181A102:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 19:39:40.487629 :C181A103:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 19:39:40.487629 :C181A104:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 19:39:40.487630 :C181A105:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 19:39:40.487630 :C181A106:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 19:39:40.488127 :C181A107:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 19:39:40.488173 :C181A10F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 19:49:41.362203 :C18266B2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 19:49:41.788974 :C1826730:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 19:49:41.784
2025-08-18 19:49:41.788977 :C1826731:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17496 pso_num=25 pso_serial#=95
2025-08-18 19:49:41.789127 :C1826732:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17496 osp_idx=23 osp_ver=245262 osp_pg=0 (spawn #502188)
2025-08-18 19:49:41.789128 :C1826733:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 19:49:41.789128 :C1826734:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=82 time=4227251095
2025-08-18 19:49:41.789128 :C1826735:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 19:49:41.789129 :C1826736:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 19:49:41.789129 :C1826737:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 19:49:41.789129 :C1826738:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 19:49:41.789130 :C1826739:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 19:49:41.789660 :C182673A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 19:49:41.789705 :C1826743:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 19:59:42.656583 :C1832CEA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 19:59:43.083426 :C1832D5B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 19:59:43.078
2025-08-18 19:59:43.083429 :C1832D5C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20296 pso_num=25 pso_serial#=96
2025-08-18 19:59:43.083579 :C1832D5D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20296 osp_idx=23 osp_ver=245263 osp_pg=0 (spawn #502210)
2025-08-18 19:59:43.083580 :C1832D5E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 19:59:43.083580 :C1832D5F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=83 time=4227852392
2025-08-18 19:59:43.083581 :C1832D60:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 19:59:43.083581 :C1832D61:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 19:59:43.083581 :C1832D62:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 19:59:43.083582 :C1832D63:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 19:59:43.083582 :C1832D64:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 19:59:43.084120 :C1832D65:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 19:59:43.084172 :C1832D6C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 20:09:44.010516 :C183FBDB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 20:09:44.421557 :C183FC51:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 20:09:44.416
2025-08-18 20:09:44.421560 :C183FC52:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21684 pso_num=25 pso_serial#=97
2025-08-18 20:09:44.421695 :C183FC53:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21684 osp_idx=23 osp_ver=245264 osp_pg=0 (spawn #502237)
2025-08-18 20:09:44.421696 :C183FC54:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 20:09:44.421696 :C183FC55:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=84 time=4228453720
2025-08-18 20:09:44.421696 :C183FC56:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 20:09:44.421697 :C183FC57:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 20:09:44.421697 :C183FC58:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 20:09:44.421697 :C183FC59:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 20:09:44.421698 :C183FC5A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 20:09:44.422277 :C183FC5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 20:09:44.422322 :C183FC62:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 20:19:45.243316 :C184C43D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 20:19:45.701406 :C184C4A7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 20:19:45.696
2025-08-18 20:19:45.701408 :C184C4A8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21508 pso_num=25 pso_serial#=98
2025-08-18 20:19:45.701548 :C184C4A9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21508 osp_idx=23 osp_ver=245265 osp_pg=0 (spawn #502260)
2025-08-18 20:19:45.701549 :C184C4AA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 20:19:45.701549 :C184C4AB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=85 time=4229055001
2025-08-18 20:19:45.701549 :C184C4AC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 20:19:45.701550 :C184C4AD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 20:19:45.701551 :C184C4AE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 20:19:45.701551 :C184C4AF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 20:19:45.701551 :C184C4B0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 20:19:45.702035 :C184C4B1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 20:19:45.702083 :C184C4B9:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 20:29:46.658627 :C1858AFD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 20:29:47.116459 :C1858B75:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 20:29:47.111
2025-08-18 20:29:47.116461 :C1858B76:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22496 pso_num=25 pso_serial#=99
2025-08-18 20:29:47.116596 :C1858B77:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22496 osp_idx=23 osp_ver=245266 osp_pg=0 (spawn #502282)
2025-08-18 20:29:47.116597 :C1858B78:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 20:29:47.116597 :C1858B79:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=86 time=4229656423
2025-08-18 20:29:47.116597 :C1858B7A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 20:29:47.116598 :C1858B7B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 20:29:47.116598 :C1858B7C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 20:29:47.116598 :C1858B7D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 20:29:47.116598 :C1858B7E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 20:29:47.117075 :C1858B7F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 20:29:47.117118 :C1858B87:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 20:39:48.009663 :C18651D6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 20:39:48.336953 :C186522E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 20:39:48.332
2025-08-18 20:39:48.336954 :C186522F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20900 pso_num=25 pso_serial#=100
2025-08-18 20:39:48.337099 :C1865230:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20900 osp_idx=23 osp_ver=245267 osp_pg=0 (spawn #502305)
2025-08-18 20:39:48.337100 :C1865231:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 20:39:48.337100 :C1865232:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=87 time=4230257642
2025-08-18 20:39:48.337101 :C1865233:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 20:39:48.337101 :C1865234:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 20:39:48.337101 :C1865235:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 20:39:48.337102 :C1865236:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 20:39:48.337102 :C1865237:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 20:39:48.337604 :C1865238:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 20:39:48.337648 :C1865240:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 20:49:49.290688 :C1871825:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 20:49:49.733037 :C187187D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 20:49:49.728
2025-08-18 20:49:49.733039 :C187187E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20428 pso_num=25 pso_serial#=101
2025-08-18 20:49:49.733177 :C187187F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20428 osp_idx=23 osp_ver=245268 osp_pg=0 (spawn #502328)
2025-08-18 20:49:49.733178 :C1871880:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 20:49:49.733178 :C1871881:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=88 time=4230859033
2025-08-18 20:49:49.733178 :C1871882:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 20:49:49.733179 :C1871883:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 20:49:49.733179 :C1871884:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 20:49:49.733179 :C1871885:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 20:49:49.733180 :C1871886:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 20:49:49.733688 :C1871887:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 20:49:49.733739 :C1871891:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 20:57:29.626824 :C187AFA5:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1
2025-08-18 20:57:29.628866 :C187AFA7:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1
2025-08-18 20:59:51.057999 :C187DEBD:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1
2025-08-18 21:09:51.963167 :C188AD73:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 21:09:52.342795 :C188ADF6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 21:09:52.337
2025-08-18 21:09:52.342797 :C188ADF7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17716 pso_num=25 pso_serial#=102
2025-08-18 21:09:52.342937 :C188ADF8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17716 osp_idx=23 osp_ver=245269 osp_pg=0 (spawn #502375)
2025-08-18 21:09:52.342938 :C188ADF9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 21:09:52.342938 :C188ADFA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=89 time=4232061642
2025-08-18 21:09:52.342938 :C188ADFB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 21:09:52.342939 :C188ADFC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 21:09:52.342939 :C188ADFD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 21:09:52.342939 :C188ADFE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 21:09:52.342940 :C188ADFF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 21:09:52.343462 :C188AE00:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 21:09:52.343507 :C188AE09:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 21:19:53.217551 :C18976FC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 21:19:53.581484 :C1897780:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 21:19:53.577
2025-08-18 21:19:53.581486 :C1897781:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19096 pso_num=25 pso_serial#=103
2025-08-18 21:19:53.581619 :C1897782:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19096 osp_idx=23 osp_ver=245270 osp_pg=0 (spawn #502398)
2025-08-18 21:19:53.581619 :C1897783:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 21:19:53.581620 :C1897784:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=90 time=4232662892
2025-08-18 21:19:53.581620 :C1897785:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 21:19:53.581620 :C1897786:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 21:19:53.581621 :C1897787:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 21:19:53.581621 :C1897788:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 21:19:53.581622 :C1897789:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 21:19:53.582109 :C189778A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 21:19:53.582158 :C1897791:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 21:29:54.555567 :C18A3D6F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 21:29:54.919785 :C18A3DCD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 21:29:54.915
2025-08-18 21:29:54.919787 :C18A3DCE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22032 pso_num=25 pso_serial#=104
2025-08-18 21:29:54.919933 :C18A3DCF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22032 osp_idx=23 osp_ver=245271 osp_pg=0 (spawn #502420)
2025-08-18 21:29:54.919934 :C18A3DD0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 21:29:54.919934 :C18A3DD1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=91 time=4233264220
2025-08-18 21:29:54.919935 :C18A3DD2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 21:29:54.919935 :C18A3DD3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 21:29:54.919935 :C18A3DD4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 21:29:54.919936 :C18A3DD5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 21:29:54.919936 :C18A3DD6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 21:29:54.920467 :C18A3DD7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 21:29:54.920521 :C18A3DE0:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 21:39:55.862093 :C18B03C7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 21:39:56.288762 :C18B042C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 21:39:56.284
2025-08-18 21:39:56.288764 :C18B042D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20068 pso_num=25 pso_serial#=105
2025-08-18 21:39:56.288899 :C18B042E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20068 osp_idx=23 osp_ver=245272 osp_pg=0 (spawn #502443)
2025-08-18 21:39:56.288900 :C18B042F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 21:39:56.288900 :C18B0430:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=92 time=4233865595
2025-08-18 21:39:56.288901 :C18B0431:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 21:39:56.288901 :C18B0432:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 21:39:56.288902 :C18B0433:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 21:39:56.288902 :C18B0434:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 21:39:56.288902 :C18B0435:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 21:39:56.289388 :C18B0436:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 21:39:56.289434 :C18B043F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 21:49:57.211061 :C18BCAD6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 21:49:57.497285 :C18BCB3C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 21:49:57.492
2025-08-18 21:49:57.497287 :C18BCB3D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13028 pso_num=25 pso_serial#=106
2025-08-18 21:49:57.497431 :C18BCB3E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13028 osp_idx=23 osp_ver=245273 osp_pg=0 (spawn #502466)
2025-08-18 21:49:57.497432 :C18BCB3F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 21:49:57.497433 :C18BCB40:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=93 time=4234466798
2025-08-18 21:49:57.497433 :C18BCB41:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 21:49:57.497434 :C18BCB42:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 21:49:57.497434 :C18BCB43:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 21:49:57.497434 :C18BCB44:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 21:49:57.497435 :C18BCB45:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 21:49:57.497949 :C18BCB46:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 21:49:57.497997 :C18BCB4D:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
2025-08-18 21:59:58.357358 :C18C900B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted
2025-08-18 21:59:58.784272 :C18C9080:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-18 21:59:58.778
2025-08-18 21:59:58.784274 :C18C9081:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22072 pso_num=25 pso_serial#=107
2025-08-18 21:59:58.784418 :C18C9082:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22072 osp_idx=23 osp_ver=245274 osp_pg=0 (spawn #502488)
2025-08-18 21:59:58.784420 :C18C9083:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A
2025-08-18 21:59:58.784420 :C18C9084:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=94 time=4235068095
2025-08-18 21:59:58.784420 :C18C9085:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs
2025-08-18 21:59:58.784421 :C18C9086:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs
2025-08-18 21:59:58.784421 :C18C9087:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs
2025-08-18 21:59:58.784422 :C18C9088:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs
2025-08-18 21:59:58.784423 :C18C9089:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs
2025-08-18 21:59:58.784961 :C18C908A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name=   type=0
2025-08-18 21:59:58.785006 :C18C9092:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name=   type=0 fac#=0 facpost=1
-------------------------------------------------------------------------------
Trace Bucket Dump End: default bucket for process 25 (osid: 22072, W000)