Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906140348\orcl_w000_22840_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906140348\orcl_w000_22840_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:34982M/63366M, Ph+PgF:39792M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 22840, image: ORACLE.EXE (W000) *** 2025-09-06 14:03:48.436 *** SESSION ID:(201.34927) 2025-09-06 14:03:48.436 *** 2025-09-06 14:03:48.436 Process diagnostic dump for ORACLE.EXE (W000), OS id=22840, pid: 25, proc_ser: 229, sid: 201, sess_ser: 34927 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=91 seq_num=92 snap_id=1 wait times: snap=2.751605 sec, exc=2.751605 sec, total=2.751605 sec wait times: max=5.000000 sec, heur=7 min 33 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.000025 sec since current wait 0: 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.004644 sec, exc=5.004644 sec, total=5.004644 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 1: 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.014686 sec, exc=5.014686 sec, total=5.014686 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000045 sec of elapsed time 2: 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.005119 sec, exc=5.005119 sec, total=5.005119 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000041 sec of elapsed time 3: 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.003547 sec, exc=5.003547 sec, total=5.003547 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 4: 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.008722 sec, exc=5.008722 sec, total=5.008722 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000045 sec of elapsed time 5: 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.000552 sec, exc=5.000552 sec, total=5.000552 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 6: 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.015243 sec, exc=5.015243 sec, total=5.015243 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 7: 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.005355 sec, exc=5.005355 sec, total=5.005355 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=82 seq_num=83 snap_id=1 wait times: snap=5.000153 sec, exc=5.000153 sec, total=5.000153 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=81 seq_num=82 snap_id=1 wait times: snap=5.000476 sec, exc=5.000476 sec, total=5.000476 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time Sampled Session History of session 201 serial 34927 --------------------------------------------------- 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, 14:01:48 - 14:03:48] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-06 14:03:48.436 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 22840, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-06 11:15:55.571716 :C9BCE0B5: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-06 11:23:50.227411 :C9BD7CEF: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-06 11:25:56.680873 :C9BDA638: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-06 11:35:57.510429 :C9BE6D45:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 11:35:57.843089 :C9BE6D78:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 11:35:57.838 2025-09-06 11:35:57.843091 :C9BE6D79:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21508 pso_num=25 pso_serial#=216 2025-09-06 11:35:57.843246 :C9BE6D7A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21508 osp_idx=23 osp_ver=282514 osp_pg=0 (spawn #564384) 2025-09-06 11:35:57.843247 :C9BE6D7B: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-06 11:35:57.843248 :C9BE6D7C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=52 time=1544209143 2025-09-06 11:35:57.843248 :C9BE6D7D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 11:35:57.843249 :C9BE6D7E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 11:35:57.843249 :C9BE6D7F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 11:35:57.843250 :C9BE6D80:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 11:35:57.843250 :C9BE6D81:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 11:35:57.843762 :C9BE6D82: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-06 11:35:57.843805 :C9BE6D8A: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-06 11:45:58.651439 :C9BF3223:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 11:45:59.046808 :C9BF325B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 11:45:59.041 2025-09-06 11:45:59.046810 :C9BF325C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23692 pso_num=25 pso_serial#=217 2025-09-06 11:45:59.046943 :C9BF325D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23692 osp_idx=23 osp_ver=282515 osp_pg=0 (spawn #564406) 2025-09-06 11:45:59.046944 :C9BF325E: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-06 11:45:59.046945 :C9BF325F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=53 time=1544810346 2025-09-06 11:45:59.046945 :C9BF3260:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 11:45:59.046945 :C9BF3261:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 11:45:59.046946 :C9BF3262:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 11:45:59.046946 :C9BF3263:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 11:45:59.046946 :C9BF3264:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 11:45:59.047483 :C9BF3265: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-06 11:45:59.047543 :C9BF326F: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-06 11:55:59.898917 :C9BFF892:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 11:56:00.247257 :C9BFF8D4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 11:56:00.242 2025-09-06 11:56:00.247259 :C9BFF8D5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24040 pso_num=25 pso_serial#=218 2025-09-06 11:56:00.247402 :C9BFF8D6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24040 osp_idx=23 osp_ver=282516 osp_pg=0 (spawn #564429) 2025-09-06 11:56:00.247402 :C9BFF8D7: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-06 11:56:00.247403 :C9BFF8D8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=54 time=1545411549 2025-09-06 11:56:00.247403 :C9BFF8D9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 11:56:00.247403 :C9BFF8DA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 11:56:00.247404 :C9BFF8DB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 11:56:00.247404 :C9BFF8DC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 11:56:00.247404 :C9BFF8DD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 11:56:00.247901 :C9BFF8DE: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-06 11:56:00.247948 :C9BFF8E5: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-06 12:06:01.146967 :C9C0C648:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 12:06:01.526829 :C9C0C686:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 12:06:01.521 2025-09-06 12:06:01.526831 :C9C0C687:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22540 pso_num=25 pso_serial#=219 2025-09-06 12:06:01.526971 :C9C0C688:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22540 osp_idx=23 osp_ver=282517 osp_pg=0 (spawn #564455) 2025-09-06 12:06:01.526972 :C9C0C689: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-06 12:06:01.526972 :C9C0C68A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=55 time=1546012830 2025-09-06 12:06:01.526973 :C9C0C68B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 12:06:01.526973 :C9C0C68C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 12:06:01.526973 :C9C0C68D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 12:06:01.526974 :C9C0C68E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 12:06:01.526974 :C9C0C68F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 12:06:01.527458 :C9C0C690: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-06 12:06:01.527506 :C9C0C697: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-06 12:16:02.366120 :C9C18DE8:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 12:16:02.714671 :C9C18E22:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 12:16:02.709 2025-09-06 12:16:02.714673 :C9C18E23:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24568 pso_num=25 pso_serial#=220 2025-09-06 12:16:02.714814 :C9C18E24:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24568 osp_idx=23 osp_ver=282518 osp_pg=0 (spawn #564477) 2025-09-06 12:16:02.714815 :C9C18E25: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-06 12:16:02.714816 :C9C18E26:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=56 time=1546614018 2025-09-06 12:16:02.714816 :C9C18E27:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 12:16:02.714816 :C9C18E28:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 12:16:02.714817 :C9C18E29:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 12:16:02.714817 :C9C18E2A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 12:16:02.714817 :C9C18E2B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 12:16:02.715307 :C9C18E2C: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-06 12:16:02.715352 :C9C18E34: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-06 12:26:03.474468 :C9C25453:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 12:26:03.869842 :C9C254A0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 12:26:03.865 2025-09-06 12:26:03.869843 :C9C254A1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19356 pso_num=25 pso_serial#=221 2025-09-06 12:26:03.869984 :C9C254A2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19356 osp_idx=23 osp_ver=282519 osp_pg=0 (spawn #564500) 2025-09-06 12:26:03.869985 :C9C254A3: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-06 12:26:03.869985 :C9C254A4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=57 time=1547215174 2025-09-06 12:26:03.869986 :C9C254A5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 12:26:03.869986 :C9C254A6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 12:26:03.869986 :C9C254A7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 12:26:03.869987 :C9C254A8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 12:26:03.869987 :C9C254A9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 12:26:03.870495 :C9C254AA: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-06 12:26:03.870541 :C9C254B1: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-06 12:36:04.634705 :C9C31D10:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 12:36:05.076997 :C9C31D65:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 12:36:05.072 2025-09-06 12:36:05.076999 :C9C31D66:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23216 pso_num=25 pso_serial#=222 2025-09-06 12:36:05.077156 :C9C31D67:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23216 osp_idx=23 osp_ver=282520 osp_pg=0 (spawn #564523) 2025-09-06 12:36:05.077157 :C9C31D68: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-06 12:36:05.077157 :C9C31D69:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=58 time=1547816377 2025-09-06 12:36:05.077157 :C9C31D6A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 12:36:05.077158 :C9C31D6B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 12:36:05.077158 :C9C31D6C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 12:36:05.077158 :C9C31D6D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 12:36:05.077159 :C9C31D6E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 12:36:05.077660 :C9C31D6F: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-06 12:36:05.077706 :C9C31D76: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-06 12:46:05.902822 :C9C3E51F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 12:46:06.204459 :C9C3E568:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 12:46:06.199 2025-09-06 12:46:06.204461 :C9C3E569:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23164 pso_num=25 pso_serial#=223 2025-09-06 12:46:06.204599 :C9C3E56A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23164 osp_idx=23 osp_ver=282521 osp_pg=0 (spawn #564545) 2025-09-06 12:46:06.204599 :C9C3E56B: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-06 12:46:06.204600 :C9C3E56C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=59 time=1548417502 2025-09-06 12:46:06.204601 :C9C3E56D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 12:46:06.204601 :C9C3E56E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 12:46:06.204601 :C9C3E56F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 12:46:06.204601 :C9C3E570:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 12:46:06.204601 :C9C3E571:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 12:46:06.205098 :C9C3E572: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-06 12:46:06.205144 :C9C3E579: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-06 12:56:07.137666 :C9C4AC30:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 12:56:07.579858 :C9C4AC8A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 12:56:07.575 2025-09-06 12:56:07.579860 :C9C4AC8B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16984 pso_num=25 pso_serial#=224 2025-09-06 12:56:07.579997 :C9C4AC8C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16984 osp_idx=23 osp_ver=282522 osp_pg=0 (spawn #564568) 2025-09-06 12:56:07.579997 :C9C4AC8D: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-06 12:56:07.579998 :C9C4AC8E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=60 time=1549018877 2025-09-06 12:56:07.579998 :C9C4AC8F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 12:56:07.579999 :C9C4AC90:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 12:56:07.579999 :C9C4AC91:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 12:56:07.579999 :C9C4AC92:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 12:56:07.580000 :C9C4AC93:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 12:56:07.580487 :C9C4AC94: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-06 12:56:07.580529 :C9C4AC9C: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-06 13:06:08.387216 :C9C57FE6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 13:06:08.814025 :C9C5801D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 13:06:08.809 2025-09-06 13:06:08.814027 :C9C5801E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23940 pso_num=25 pso_serial#=225 2025-09-06 13:06:08.814162 :C9C5801F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23940 osp_idx=23 osp_ver=282523 osp_pg=0 (spawn #564594) 2025-09-06 13:06:08.814163 :C9C58020: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-06 13:06:08.814163 :C9C58021:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=61 time=1549620112 2025-09-06 13:06:08.814164 :C9C58022:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 13:06:08.814165 :C9C58023:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 13:06:08.814165 :C9C58024:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 13:06:08.814165 :C9C58025:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 13:06:08.814165 :C9C58026:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 13:06:08.814654 :C9C58027: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-06 13:06:08.814705 :C9C58031: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-06 13:16:09.608606 :C9C646E3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 13:16:10.082156 :C9C64728:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 13:16:10.077 2025-09-06 13:16:10.082158 :C9C64729:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21040 pso_num=25 pso_serial#=226 2025-09-06 13:16:10.082328 :C9C6472A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21040 osp_idx=23 osp_ver=282524 osp_pg=0 (spawn #564616) 2025-09-06 13:16:10.082329 :C9C6472B: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-06 13:16:10.082329 :C9C6472C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=62 time=1550221393 2025-09-06 13:16:10.082329 :C9C6472D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 13:16:10.082330 :C9C6472E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 13:16:10.082330 :C9C6472F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 13:16:10.082330 :C9C64730:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 13:16:10.082331 :C9C64731:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 13:16:10.082830 :C9C64732: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-06 13:16:10.082879 :C9C64739: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-06 13:26:10.868495 :C9C7118B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 13:26:11.388925 :C9C711C3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 13:26:11.384 2025-09-06 13:26:11.388927 :C9C711C4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20640 pso_num=25 pso_serial#=227 2025-09-06 13:26:11.389064 :C9C711C5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20640 osp_idx=23 osp_ver=282525 osp_pg=0 (spawn #564639) 2025-09-06 13:26:11.389065 :C9C711C6: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-06 13:26:11.389065 :C9C711C7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=63 time=1550822690 2025-09-06 13:26:11.389066 :C9C711C8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 13:26:11.389066 :C9C711C9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 13:26:11.389067 :C9C711CA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 13:26:11.389067 :C9C711CB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 13:26:11.389067 :C9C711CC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 13:26:11.389560 :C9C711CD: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-06 13:26:11.389610 :C9C711D4: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-06 13:27:43.591312 :C9C73074: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-06 13:36:12.623725 :C9C7DA34: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-06 13:46:13.376136 :C9C8A311:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 13:46:13.927950 :C9C8A359:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 13:46:13.922 2025-09-06 13:46:13.927952 :C9C8A35A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22152 pso_num=25 pso_serial#=228 2025-09-06 13:46:13.928096 :C9C8A35B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22152 osp_idx=23 osp_ver=282526 osp_pg=0 (spawn #564683) 2025-09-06 13:46:13.928097 :C9C8A35C: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-06 13:46:13.928097 :C9C8A35D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=64 time=1552025237 2025-09-06 13:46:13.928098 :C9C8A35E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 13:46:13.928098 :C9C8A35F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 13:46:13.928099 :C9C8A360:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 13:46:13.928099 :C9C8A361:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 13:46:13.928099 :C9C8A362:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 13:46:13.928629 :C9C8A363: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-06 13:46:13.928677 :C9C8A36A: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-06 13:56:14.716611 :C9C9687F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-06 13:56:15.117116 :C9C968CD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-06 13:56:15.112 2025-09-06 13:56:15.117118 :C9C968CE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22840 pso_num=25 pso_serial#=229 2025-09-06 13:56:15.117260 :C9C968CF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22840 osp_idx=23 osp_ver=282527 osp_pg=0 (spawn #564706) 2025-09-06 13:56:15.117260 :C9C968D0: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-06 13:56:15.117261 :C9C968D1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=65 time=1552626424 2025-09-06 13:56:15.117261 :C9C968D2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 13:56:15.117262 :C9C968D3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 13:56:15.117262 :C9C968D4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 13:56:15.117263 :C9C968D5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 13:56:15.117263 :C9C968D6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 13:56:15.117773 :C9C968D7: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-06 13:56:15.117818 :C9C968DF: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: 22840, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de