Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250914180732\orcl_w000_25588_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250914180732\orcl_w000_25588_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:34770M/63366M, Ph+PgF:39361M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 25588, image: ORACLE.EXE (W000) *** 2025-09-14 18:07:32.547 *** SESSION ID:(201.5459) 2025-09-14 18:07:32.547 *** 2025-09-14 18:07:32.547 Process diagnostic dump for ORACLE.EXE (W000), OS id=25588, pid: 25, proc_ser: 116, sid: 201, sess_ser: 5459 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=93 seq_num=94 snap_id=1 wait times: snap=0.257065 sec, exc=0.257065 sec, total=0.257065 sec wait times: max=5.000000 sec, heur=7 min 40 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.000045 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=92 seq_num=93 snap_id=1 wait times: snap=5.005593 sec, exc=5.005593 sec, total=5.005593 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=91 seq_num=92 snap_id=1 wait times: snap=5.000259 sec, exc=5.000259 sec, total=5.000259 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=90 seq_num=91 snap_id=1 wait times: snap=5.012078 sec, exc=5.012078 sec, total=5.012078 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=89 seq_num=90 snap_id=1 wait times: snap=5.007381 sec, exc=5.007381 sec, total=5.007381 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000032 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=88 seq_num=89 snap_id=1 wait times: snap=5.014760 sec, exc=5.014760 sec, total=5.014760 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000017 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=87 seq_num=88 snap_id=1 wait times: snap=5.004628 sec, exc=5.004628 sec, total=5.004628 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=86 seq_num=87 snap_id=1 wait times: snap=5.004621 sec, exc=5.004621 sec, total=5.004621 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=85 seq_num=86 snap_id=1 wait times: snap=5.007234 sec, exc=5.007234 sec, total=5.007234 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=84 seq_num=85 snap_id=1 wait times: snap=5.001567 sec, exc=5.001567 sec, total=5.001567 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=83 seq_num=84 snap_id=1 wait times: snap=5.013327 sec, exc=5.013327 sec, total=5.013327 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time Sampled Session History of session 201 serial 5459 --------------------------------------------------- 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, 18:05:32 - 18:07:32] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-14 18:07:32.547 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 25588, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-14 15:49:34.937190 :CD5BCCB9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23052 pso_num=25 pso_serial#=101 2025-09-14 15:49:34.937331 :CD5BCCBA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23052 osp_idx=23 osp_ver=298719 osp_pg=0 (spawn #591656) 2025-09-14 15:49:34.937331 :CD5BCCBB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 15:49:34.937332 :CD5BCCBC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=228 time=2250626237 2025-09-14 15:49:34.937332 :CD5BCCBD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 15:49:34.937333 :CD5BCCBE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 15:49:34.937333 :CD5BCCBF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 15:49:34.937333 :CD5BCCC0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 15:49:34.937334 :CD5BCCC1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 15:49:34.937820 :CD5BCCC2: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-09-14 15:49:34.937872 :CD5BCCC8: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-09-14 15:59:35.876195 :CD5C951E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 15:59:36.240709 :CD5C95A2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 15:59:36.235 2025-09-14 15:59:36.240711 :CD5C95A3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24616 pso_num=25 pso_serial#=102 2025-09-14 15:59:36.240846 :CD5C95A4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24616 osp_idx=23 osp_ver=298720 osp_pg=0 (spawn #591679) 2025-09-14 15:59:36.240847 :CD5C95A5:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 15:59:36.240847 :CD5C95A6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=229 time=2251227549 2025-09-14 15:59:36.240848 :CD5C95A7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 15:59:36.240848 :CD5C95A8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 15:59:36.240848 :CD5C95A9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 15:59:36.240849 :CD5C95AA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 15:59:36.240849 :CD5C95AB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 15:59:36.241397 :CD5C95AC: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-09-14 15:59:36.241443 :CD5C95B4: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-09-14 16:05:58.700087 :CD5D1DCB: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-09-14 16:09:37.477756 :CD5D6A9B: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-09-14 16:19:38.408324 :CD5E33A8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 16:19:38.709635 :CD5E341E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 16:19:38.704 2025-09-14 16:19:38.709637 :CD5E341F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23712 pso_num=25 pso_serial#=103 2025-09-14 16:19:38.709774 :CD5E3420:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23712 osp_idx=23 osp_ver=298721 osp_pg=0 (spawn #591727) 2025-09-14 16:19:38.709775 :CD5E3421:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 16:19:38.709775 :CD5E3422:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=230 time=2252430018 2025-09-14 16:19:38.709775 :CD5E3423:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 16:19:38.709776 :CD5E3424:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 16:19:38.709776 :CD5E3425:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 16:19:38.709776 :CD5E3426:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 16:19:38.709776 :CD5E3427:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 16:19:38.710275 :CD5E3428: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-09-14 16:19:38.710323 :CD5E342F: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-09-14 16:29:39.604935 :CD5EFD46:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 16:29:39.922102 :CD5EFDAE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 16:29:39.917 2025-09-14 16:29:39.922104 :CD5EFDAF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25420 pso_num=25 pso_serial#=104 2025-09-14 16:29:39.922256 :CD5EFDB0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25420 osp_idx=23 osp_ver=298722 osp_pg=0 (spawn #591750) 2025-09-14 16:29:39.922256 :CD5EFDB1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 16:29:39.922257 :CD5EFDB2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=231 time=2253031221 2025-09-14 16:29:39.922257 :CD5EFDB3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 16:29:39.922258 :CD5EFDB4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 16:29:39.922258 :CD5EFDB5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 16:29:39.922258 :CD5EFDB6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 16:29:39.922259 :CD5EFDB7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 16:29:39.922782 :CD5EFDB8: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-09-14 16:29:39.922827 :CD5EFDC0: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-09-14 16:39:40.839877 :CD5FC6C2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 16:39:41.235232 :CD5FC737:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 16:39:41.230 2025-09-14 16:39:41.235234 :CD5FC738:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20048 pso_num=25 pso_serial#=105 2025-09-14 16:39:41.235379 :CD5FC739:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20048 osp_idx=23 osp_ver=298723 osp_pg=0 (spawn #591772) 2025-09-14 16:39:41.235379 :CD5FC73A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 16:39:41.235380 :CD5FC73B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=232 time=2253632533 2025-09-14 16:39:41.235380 :CD5FC73C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 16:39:41.235380 :CD5FC73D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 16:39:41.235381 :CD5FC73E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 16:39:41.235381 :CD5FC73F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 16:39:41.235382 :CD5FC740:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 16:39:41.235885 :CD5FC741: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-09-14 16:39:41.235931 :CD5FC74A: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-09-14 16:49:42.018455 :CD6091FC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 16:49:42.461235 :CD609268:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 16:49:42.456 2025-09-14 16:49:42.461237 :CD609269:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23324 pso_num=25 pso_serial#=106 2025-09-14 16:49:42.461384 :CD60926A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23324 osp_idx=23 osp_ver=298724 osp_pg=0 (spawn #591795) 2025-09-14 16:49:42.461385 :CD60926B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 16:49:42.461385 :CD60926C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=233 time=2254233768 2025-09-14 16:49:42.461386 :CD60926D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 16:49:42.461386 :CD60926E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 16:49:42.461387 :CD60926F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 16:49:42.461387 :CD609270:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 16:49:42.461387 :CD609271:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 16:49:42.462009 :CD609272: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-09-14 16:49:42.462078 :CD60927C: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-09-14 16:59:43.396267 :CD615C8F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 16:59:43.729751 :CD615D02:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 16:59:43.724 2025-09-14 16:59:43.729754 :CD615D03:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21880 pso_num=25 pso_serial#=107 2025-09-14 16:59:43.729933 :CD615D04:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21880 osp_idx=23 osp_ver=298725 osp_pg=0 (spawn #591818) 2025-09-14 16:59:43.729933 :CD615D05:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 16:59:43.729934 :CD615D06:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=234 time=2254835033 2025-09-14 16:59:43.729934 :CD615D07:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 16:59:43.729935 :CD615D08:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 16:59:43.729935 :CD615D09:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 16:59:43.729935 :CD615D0A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 16:59:43.729936 :CD615D0B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 16:59:43.730512 :CD615D0C: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-09-14 16:59:43.730562 :CD615D13: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-09-14 17:09:44.635044 :CD623161:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:09:45.008956 :CD6231CF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:09:45.004 2025-09-14 17:09:45.008958 :CD6231D0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25268 pso_num=25 pso_serial#=108 2025-09-14 17:09:45.009105 :CD6231D1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25268 osp_idx=23 osp_ver=298726 osp_pg=0 (spawn #591843) 2025-09-14 17:09:45.009106 :CD6231D2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 17:09:45.009106 :CD6231D3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=235 time=2255436315 2025-09-14 17:09:45.009107 :CD6231D4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 17:09:45.009107 :CD6231D5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 17:09:45.009108 :CD6231D6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 17:09:45.009108 :CD6231D7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 17:09:45.009108 :CD6231D8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 17:09:45.009613 :CD6231D9: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-09-14 17:09:45.009660 :CD6231E1: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-09-14 17:19:45.933341 :CD62FAED:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:19:46.312992 :CD62FB62:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:19:46.308 2025-09-14 17:19:46.312995 :CD62FB63:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18800 pso_num=25 pso_serial#=109 2025-09-14 17:19:46.313136 :CD62FB64:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18800 osp_idx=23 osp_ver=298727 osp_pg=0 (spawn #591866) 2025-09-14 17:19:46.313136 :CD62FB65:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 17:19:46.313137 :CD62FB66:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=236 time=2256037612 2025-09-14 17:19:46.313137 :CD62FB67:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 17:19:46.313137 :CD62FB68:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 17:19:46.313138 :CD62FB69:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 17:19:46.313138 :CD62FB6A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 17:19:46.313139 :CD62FB6B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 17:19:46.313634 :CD62FB6C: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-09-14 17:19:46.313680 :CD62FB75: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-09-14 17:29:47.152077 :CD63C45E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:29:47.291605 :CD63C461:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:29:47.277 2025-09-14 17:29:47.291607 :CD63C462:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21544 pso_num=25 pso_serial#=110 2025-09-14 17:29:47.291751 :CD63C463:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=21544 (legacy spawn) 2025-09-14 17:29:47.298344 :CD63C464:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-14 17:29:47.298525 :CD63C469:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-14 17:29:47.299319 :CD63C46E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:29:47.308169 :CD63C471:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:29:47.308 2025-09-14 17:29:47.308171 :CD63C472:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22084 pso_num=25 pso_serial#=111 2025-09-14 17:29:47.308319 :CD63C473:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=22084 (legacy spawn) 2025-09-14 17:29:47.314745 :CD63C474:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-14 17:29:47.314909 :CD63C47D:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-14 17:29:47.315718 :CD63C47E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:29:47.624874 :CD63C4E3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:29:47.620 2025-09-14 17:29:47.624876 :CD63C4E4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24580 pso_num=25 pso_serial#=112 2025-09-14 17:29:47.625017 :CD63C4E5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24580 osp_idx=23 osp_ver=298730 osp_pg=0 (spawn #591889) 2025-09-14 17:29:47.625018 :CD63C4E6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 17:29:47.625018 :CD63C4E7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=237 time=2256638924 2025-09-14 17:29:47.625019 :CD63C4E8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 17:29:47.625019 :CD63C4E9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 17:29:47.625019 :CD63C4EA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 17:29:47.625022 :CD63C4EB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 17:29:47.625022 :CD63C4EC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 17:29:47.625512 :CD63C4ED: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-09-14 17:29:47.625558 :CD63C4F4: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-09-14 17:39:48.510981 :CD648D56:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:39:48.978327 :CD648DC9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:39:48.974 2025-09-14 17:39:48.978329 :CD648DCA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21376 pso_num=25 pso_serial#=113 2025-09-14 17:39:48.978469 :CD648DCB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21376 osp_idx=23 osp_ver=298731 osp_pg=0 (spawn #591911) 2025-09-14 17:39:48.978470 :CD648DCC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 17:39:48.978470 :CD648DCD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=238 time=2257240283 2025-09-14 17:39:48.978470 :CD648DCE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 17:39:48.978471 :CD648DCF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 17:39:48.978471 :CD648DD0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 17:39:48.978472 :CD648DD1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 17:39:48.978472 :CD648DD2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 17:39:48.978975 :CD648DD3: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-09-14 17:39:48.979020 :CD648DDB: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-09-14 17:49:49.945900 :CD6556D0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:49:50.309389 :CD655733:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:49:50.305 2025-09-14 17:49:50.309391 :CD655734:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25232 pso_num=25 pso_serial#=114 2025-09-14 17:49:50.309579 :CD655735:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25232 osp_idx=23 osp_ver=298732 osp_pg=0 (spawn #591934) 2025-09-14 17:49:50.309580 :CD655736:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 17:49:50.309581 :CD655737:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=239 time=2257841612 2025-09-14 17:49:50.309581 :CD655738:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 17:49:50.309581 :CD655739:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 17:49:50.309582 :CD65573A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 17:49:50.309582 :CD65573B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 17:49:50.309582 :CD65573C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 17:49:50.310079 :CD65573D: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-09-14 17:49:50.310123 :CD655744: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-09-14 17:59:51.152496 :CD661FF0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:59:51.444255 :CD661FFF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:59:51.433 2025-09-14 17:59:51.444258 :CD662000:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23608 pso_num=25 pso_serial#=115 2025-09-14 17:59:51.444464 :CD662001:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=23608 (legacy spawn) 2025-09-14 17:59:51.451528 :CD662002:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-14 17:59:51.451720 :CD662007:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-14 17:59:51.452576 :CD66200C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 17:59:51.641660 :CD662074:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 17:59:51.637 2025-09-14 17:59:51.641662 :CD662075:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25588 pso_num=25 pso_serial#=116 2025-09-14 17:59:51.641802 :CD662076:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25588 osp_idx=23 osp_ver=298734 osp_pg=0 (spawn #591957) 2025-09-14 17:59:51.641803 :CD662077:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 17:59:51.641803 :CD662078:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=240 time=2258442940 2025-09-14 17:59:51.641804 :CD662079:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 17:59:51.641804 :CD66207A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 17:59:51.641804 :CD66207B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 17:59:51.641805 :CD66207C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 17:59:51.641805 :CD66207D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 17:59:51.642296 :CD66207E: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-09-14 17:59:51.642343 :CD662085: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: 25588, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de