Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906222049\orcl_j001_23756_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250906222049\orcl_j001_23756_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:35016M/63366M, Ph+PgF:39836M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 23756, image: ORACLE.EXE (J001) *** 2025-09-06 22:20:49.979 *** SESSION ID:(209.37523) 2025-09-06 22:20:49.979 *** 2025-09-06 22:20:49.979 Process diagnostic dump for ORACLE.EXE (J001), OS id=23756, pid: 26, proc_ser: 184, sid: 209, sess_ser: 37523 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 23756 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=34 seq_num=35 snap_id=1 wait times: snap=0.337786 sec, exc=0.337786 sec, total=0.337786 sec wait times: max=0.500000 sec, heur=17.374885 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.000012 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=33 seq_num=34 snap_id=1 wait times: snap=0.499981 sec, exc=0.499981 sec, total=0.499981 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=0.502003 sec, exc=0.502003 sec, total=0.502003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000016 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=0.500012 sec, exc=0.500012 sec, total=0.500012 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=30 seq_num=31 snap_id=1 wait times: snap=0.500177 sec, exc=0.500177 sec, total=0.500177 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=28 seq_num=29 snap_id=1 wait times: snap=0.500008 sec, exc=0.500008 sec, total=0.500008 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=0.499988 sec, exc=0.499988 sec, total=0.499988 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=26 seq_num=27 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=25 seq_num=26 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=24 seq_num=25 snap_id=1 wait times: snap=0.500165 sec, exc=0.500165 sec, total=0.500165 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time Sampled Session History of session 209 serial 37523 --------------------------------------------------- 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 --------------------------------------------------- [18 samples, 22:20:32 - 22:20:49] idle wait at each sample [session created at: 22:20:32] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-06 22:20:49.979 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 23756, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-06 22:05:31.271761 :C9EF1ED1:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:05:31.271761 :C9EF1ED2:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:05:31.271761 :C9EF1ED3:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:05:31.272298 :C9EF1ED4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:06:01.364851 :C9EF2F52:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:06:31.390152 :C9EF38D5:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:06:31.379 2025-09-06 22:06:31.390155 :C9EF38D6:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24036 pso_num=26 pso_serial#=170 2025-09-06 22:06:31.390347 :C9EF38D7:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=24036 osp_idx=24 osp_ver=803175 osp_pg=0 (spawn #565849) 2025-09-06 22:06:31.390348 :C9EF38D8:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:06:31.390349 :C9EF38D9:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=242 time=1582042690 2025-09-06 22:06:31.390349 :C9EF38DA:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:06:31.390350 :C9EF38DB:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:06:31.390350 :C9EF38DC:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:06:31.390351 :C9EF38DD:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:06:31.390351 :C9EF38DE:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:06:31.390844 :C9EF38DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:07:01.469978 :C9EF427A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:07:31.447816 :C9EF4C51:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:07:31.436 2025-09-06 22:07:31.447818 :C9EF4C52:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=21756 pso_num=26 pso_serial#=171 2025-09-06 22:07:31.447944 :C9EF4C53:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=21756 osp_idx=24 osp_ver=803176 osp_pg=0 (spawn #565852) 2025-09-06 22:07:31.447945 :C9EF4C54:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:07:31.447945 :C9EF4C55:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=243 time=1582102752 2025-09-06 22:07:31.447946 :C9EF4C56:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:07:31.447946 :C9EF4C57:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:07:31.447947 :C9EF4C58:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:07:31.447947 :C9EF4C59:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:07:31.447947 :C9EF4C5A:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:07:31.448424 :C9EF4C5B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:08:01.495798 :C9EF5631:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:08:16.496070 :C9EF5B34:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:08:16.485 2025-09-06 22:08:16.496073 :C9EF5B35:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20068 pso_num=26 pso_serial#=172 2025-09-06 22:08:16.496218 :C9EF5B36:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=20068 osp_idx=24 osp_ver=803177 osp_pg=0 (spawn #565854) 2025-09-06 22:08:16.496219 :C9EF5B37:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:08:16.496219 :C9EF5B38:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=244 time=1582147799 2025-09-06 22:08:16.496219 :C9EF5B39:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:08:16.496220 :C9EF5B3A:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:08:16.496220 :C9EF5B3B:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:08:16.496221 :C9EF5B3C:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:08:16.496221 :C9EF5B3D:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:08:16.496711 :C9EF5B3E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:08:31.493964 :C9EF600D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-06 22:09:01.580880 :C9EF69D5:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:09:31.581000 :C9EF735A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:09:31.569 2025-09-06 22:09:31.581002 :C9EF735B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23656 pso_num=26 pso_serial#=173 2025-09-06 22:09:31.581123 :C9EF735C:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23656 osp_idx=24 osp_ver=803178 osp_pg=0 (spawn #565856) 2025-09-06 22:09:31.581123 :C9EF735D:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:09:31.581124 :C9EF735E:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=245 time=1582222877 2025-09-06 22:09:31.581124 :C9EF735F:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:09:31.581125 :C9EF7360:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:09:31.581125 :C9EF7361:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:09:31.581125 :C9EF7362:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:09:31.581126 :C9EF7363:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:09:31.581592 :C9EF7364:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:10:01.667051 :C9EF7ED9:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:10:31.666388 :C9EF887A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:10:31.655 2025-09-06 22:10:31.666391 :C9EF887B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20336 pso_num=26 pso_serial#=174 2025-09-06 22:10:31.666535 :C9EF887C:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=20336 osp_idx=24 osp_ver=803179 osp_pg=0 (spawn #565858) 2025-09-06 22:10:31.666536 :C9EF887D:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:10:31.666536 :C9EF887E:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=246 time=1582282971 2025-09-06 22:10:31.666537 :C9EF887F:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:10:31.666537 :C9EF8880:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:10:31.666538 :C9EF8881:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:10:31.666538 :C9EF8882:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:10:31.666538 :C9EF8883:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:10:31.667048 :C9EF8884:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:11:01.737511 :C9EF91DB:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:11:31.735768 :C9EF9B93:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:11:31.724 2025-09-06 22:11:31.735770 :C9EF9B94:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20860 pso_num=26 pso_serial#=175 2025-09-06 22:11:31.735895 :C9EF9B95:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=20860 osp_idx=24 osp_ver=803180 osp_pg=0 (spawn #565860) 2025-09-06 22:11:31.735895 :C9EF9B96:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:11:31.735896 :C9EF9B97:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=247 time=1582343033 2025-09-06 22:11:31.735896 :C9EF9B98:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:11:31.735897 :C9EF9B99:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:11:31.735897 :C9EF9B9A:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:11:31.735898 :C9EF9B9B:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:11:31.735898 :C9EF9B9C:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:11:31.736364 :C9EF9B9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:12:01.800079 :C9EFA527:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:12:31.848683 :C9EFAEBD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:12:31.837 2025-09-06 22:12:31.848685 :C9EFAEBE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=8988 pso_num=26 pso_serial#=176 2025-09-06 22:12:31.848802 :C9EFAEBF:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=8988 osp_idx=24 osp_ver=803181 osp_pg=0 (spawn #565862) 2025-09-06 22:12:31.848803 :C9EFAEC0:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:12:31.848803 :C9EFAEC1:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=248 time=1582403143 2025-09-06 22:12:31.848803 :C9EFAEC2:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:12:31.848804 :C9EFAEC3:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:12:31.848804 :C9EFAEC4:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:12:31.848804 :C9EFAEC5:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:12:31.848805 :C9EFAEC6:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:12:31.849308 :C9EFAEC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:13:01.922040 :C9EFB881:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:13:31.947494 :C9EFC236:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:13:31.936 2025-09-06 22:13:31.947496 :C9EFC237:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=20568 pso_num=26 pso_serial#=177 2025-09-06 22:13:31.947616 :C9EFC238:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=20568 osp_idx=24 osp_ver=803182 osp_pg=0 (spawn #565864) 2025-09-06 22:13:31.947617 :C9EFC239:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:13:31.947617 :C9EFC23A:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=249 time=1582463252 2025-09-06 22:13:31.947618 :C9EFC23B:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:13:31.947618 :C9EFC23C:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:13:31.947618 :C9EFC23D:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:13:31.947618 :C9EFC23E:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:13:31.947619 :C9EFC23F:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:13:31.948109 :C9EFC240:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:14:02.043048 :C9EFCBD3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:14:32.050889 :C9EFD572:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:14:32.039 2025-09-06 22:14:32.050892 :C9EFD573:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23316 pso_num=26 pso_serial#=178 2025-09-06 22:14:32.051026 :C9EFD574:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23316 osp_idx=24 osp_ver=803183 osp_pg=0 (spawn #565866) 2025-09-06 22:14:32.051027 :C9EFD575:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:14:32.051028 :C9EFD576:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=250 time=1582523346 2025-09-06 22:14:32.051028 :C9EFD577:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:14:32.051028 :C9EFD578:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:14:32.051029 :C9EFD579:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:14:32.051029 :C9EFD57A:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:14:32.051029 :C9EFD57B:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:14:32.051552 :C9EFD57C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:15:02.129800 :C9EFE053:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:15:32.125378 :C9EFE9D3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:15:32.114 2025-09-06 22:15:32.125379 :C9EFE9D4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23244 pso_num=26 pso_serial#=179 2025-09-06 22:15:32.125504 :C9EFE9D5:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23244 osp_idx=24 osp_ver=803184 osp_pg=0 (spawn #565869) 2025-09-06 22:15:32.125504 :C9EFE9D6:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:15:32.125505 :C9EFE9D7:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=251 time=1582583424 2025-09-06 22:15:32.125505 :C9EFE9D8:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:15:32.125505 :C9EFE9D9:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:15:32.125506 :C9EFE9DA:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:15:32.125506 :C9EFE9DB:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:15:32.125506 :C9EFE9DC:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:15:32.126028 :C9EFE9DD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:16:02.218283 :C9EFF36E:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:16:32.212437 :C9EFFCEF:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:16:32.200 2025-09-06 22:16:32.212439 :C9EFFCF0:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24128 pso_num=26 pso_serial#=180 2025-09-06 22:16:32.212559 :C9EFFCF1:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=24128 osp_idx=24 osp_ver=803185 osp_pg=0 (spawn #565871) 2025-09-06 22:16:32.212559 :C9EFFCF2:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:16:32.212560 :C9EFFCF3:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=252 time=1582643502 2025-09-06 22:16:32.212561 :C9EFFCF4:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:16:32.212561 :C9EFFCF5:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:16:32.212562 :C9EFFCF6:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:16:32.212562 :C9EFFCF7:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:16:32.212562 :C9EFFCF8:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:16:32.213079 :C9EFFCF9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:17:02.297412 :C9F00666:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:17:32.331756 :C9F0104B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:17:32.320 2025-09-06 22:17:32.331758 :C9F0104C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22176 pso_num=26 pso_serial#=181 2025-09-06 22:17:32.331881 :C9F0104D:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22176 osp_idx=24 osp_ver=803186 osp_pg=0 (spawn #565874) 2025-09-06 22:17:32.331882 :C9F0104E:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:17:32.331882 :C9F0104F:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=253 time=1582703627 2025-09-06 22:17:32.331883 :C9F01050:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:17:32.331883 :C9F01051:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:17:32.331883 :C9F01052:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:17:32.331884 :C9F01053:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:17:32.331884 :C9F01054:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:17:32.332370 :C9F01055:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:18:02.445069 :C9F01A89:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:18:17.426229 :C9F01F53:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:18:17.414 2025-09-06 22:18:17.426231 :C9F01F54:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23624 pso_num=26 pso_serial#=182 2025-09-06 22:18:17.426363 :C9F01F55:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23624 osp_idx=24 osp_ver=803187 osp_pg=0 (spawn #565876) 2025-09-06 22:18:17.426364 :C9F01F56:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:18:17.426364 :C9F01F57:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=254 time=1582748721 2025-09-06 22:18:17.426365 :C9F01F58:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:18:17.426365 :C9F01F59:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:18:17.426366 :C9F01F5A:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:18:17.426366 :C9F01F5B:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:18:17.426367 :C9F01F5C:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:18:17.426935 :C9F01F5D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:18:32.451208 :C9F0245D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-06 22:19:02.516249 :C9F02DEA:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:19:32.530281 :C9F03714:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:19:32.524 2025-09-06 22:19:32.530283 :C9F03715:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22708 pso_num=26 pso_serial#=183 2025-09-06 22:19:32.530420 :C9F03716:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22708 osp_idx=24 osp_ver=803188 osp_pg=0 (spawn #565877) 2025-09-06 22:19:32.530422 :C9F03717:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:19:32.530422 :C9F03718:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=255 time=1582823830 2025-09-06 22:19:32.530423 :C9F03719:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:19:32.530423 :C9F0371A:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:19:32.530423 :C9F0371B:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:19:32.530424 :C9F0371C:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:19:32.530424 :C9F0371D:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:19:32.530897 :C9F0371E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-06 22:19:32.531537 :C9F03733:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:19:32.539173 :C9F03750:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-06 22:19:32.539571 :C9F03752:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:19:32.539614 :C9F0375B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-06 22:19:32.540529 :C9F03766:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-09-06 22:19:32.540676 :C9F0376F:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-09-06 22:20:02.641645 :C9F041A1:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-06 22:20:32.612205 :C9F04B27:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-06 22:20:32.601 2025-09-06 22:20:32.612207 :C9F04B28:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23756 pso_num=26 pso_serial#=184 2025-09-06 22:20:32.612324 :C9F04B29:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23756 osp_idx=24 osp_ver=803189 osp_pg=0 (spawn #565881) 2025-09-06 22:20:32.612324 :C9F04B2A:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-06 22:20:32.612325 :C9F04B2B:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=0 time=1582883908 2025-09-06 22:20:32.612325 :C9F04B2C:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-06 22:20:32.612326 :C9F04B2D:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-06 22:20:32.612326 :C9F04B2E:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-06 22:20:32.612326 :C9F04B2F:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-06 22:20:32.612327 :C9F04B30:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-06 22:20:32.612811 :C9F04B31:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 23756, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de