Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250914082432\orcl_m002_22940_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250914082432\orcl_m002_22940_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:39401M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 22940, image: ORACLE.EXE (M002) *** 2025-09-14 08:24:32.393 *** SESSION ID:(201.4667) 2025-09-14 08:24:32.393 *** 2025-09-14 08:24:32.393 Process diagnostic dump for ORACLE.EXE (M002), OS id=22940, pid: 25, proc_ser: 240, sid: 201, sess_ser: 4667 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=423 seq_num=424 snap_id=1 wait times: snap=0.004615 sec, exc=0.004615 sec, total=0.004615 sec wait times: max=infinite, heur=0.536563 sec wait counts: calls=0 os=0 in_wait=1 iflags=0x5a0 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000019 sec since current wait 0: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=422 seq_num=423 snap_id=1 wait times: snap=0.006189 sec, exc=0.006189 sec, total=0.006189 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000020 sec of elapsed time 1: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=421 seq_num=422 snap_id=1 wait times: snap=0.003905 sec, exc=0.003905 sec, total=0.003905 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000018 sec of elapsed time 2: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=420 seq_num=421 snap_id=1 wait times: snap=0.006590 sec, exc=0.006590 sec, total=0.006590 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000016 sec of elapsed time 3: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=419 seq_num=420 snap_id=1 wait times: snap=0.007026 sec, exc=0.007026 sec, total=0.007026 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000022 sec of elapsed time 4: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=418 seq_num=419 snap_id=1 wait times: snap=0.005500 sec, exc=0.005500 sec, total=0.005500 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000017 sec of elapsed time 5: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=417 seq_num=418 snap_id=1 wait times: snap=0.005595 sec, exc=0.005595 sec, total=0.005595 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000017 sec of elapsed time 6: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=416 seq_num=417 snap_id=1 wait times: snap=0.003354 sec, exc=0.003354 sec, total=0.003354 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000008 sec of elapsed time 7: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=415 seq_num=416 snap_id=1 wait times: snap=0.000346 sec, exc=0.000346 sec, total=0.000346 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000010 sec of elapsed time 8: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=414 seq_num=415 snap_id=1 wait times: snap=0.000538 sec, exc=0.000538 sec, total=0.000538 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000020 sec of elapsed time 9: waited for 'ADR block file read' =0x0, =0x0, =0x0 wait_id=413 seq_num=414 snap_id=1 wait times: snap=0.005874 sec, exc=0.005874 sec, total=0.005874 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000008 sec of elapsed time Sampled Session History of session 201 serial 4667 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [1 sample, 08:24:32] idle wait at each sample [session created at: 08:24:31] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-14 08:24:32.393 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 22940, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-14 08:10:35.876877 :CD3710DC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:11:05.960085 :CD371ABE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:11:35.972771 :CD3724AD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:11:35.961 2025-09-14 08:11:35.972773 :CD3724AE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24024 pso_num=25 pso_serial#=225 2025-09-14 08:11:35.972896 :CD3724AF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24024 osp_idx=23 osp_ver=298333 osp_pg=0 (spawn #590591) 2025-09-14 08:11:35.972897 :CD3724B0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:11:35.972897 :CD3724B1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=118 time=2223147268 2025-09-14 08:11:35.972898 :CD3724B2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:11:35.972898 :CD3724B3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:11:35.972898 :CD3724B4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:11:35.972899 :CD3724B5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:11:35.972899 :CD3724B6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:11:35.973392 :CD3724B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:12:06.055655 :CD372E75:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:12:36.050212 :CD373869:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:12:36.039 2025-09-14 08:12:36.050214 :CD37386A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24580 pso_num=25 pso_serial#=226 2025-09-14 08:12:36.050334 :CD37386B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24580 osp_idx=23 osp_ver=298334 osp_pg=0 (spawn #590593) 2025-09-14 08:12:36.050334 :CD37386C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:12:36.050335 :CD37386D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=119 time=2223207346 2025-09-14 08:12:36.050335 :CD37386E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:12:36.050336 :CD37386F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:12:36.050336 :CD373870:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:12:36.050336 :CD373871:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:12:36.050337 :CD373872:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:12:36.050815 :CD373873:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:13:06.149062 :CD374251:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:13:21.091526 :CD37470D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:13:21.080 2025-09-14 08:13:21.091527 :CD37470E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22920 pso_num=25 pso_serial#=227 2025-09-14 08:13:21.091668 :CD37470F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22920 osp_idx=23 osp_ver=298335 osp_pg=0 (spawn #590595) 2025-09-14 08:13:21.091668 :CD374710:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:13:21.091669 :CD374711:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=120 time=2223252393 2025-09-14 08:13:21.091669 :CD374712:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:13:21.091670 :CD374713:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:13:21.091671 :CD374714:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:13:21.091671 :CD374715:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:13:21.091671 :CD374716:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:13:21.092162 :CD374717:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:13:36.117295 :CD374C22:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-14 08:14:06.191313 :CD3755E1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:14:36.220511 :CD375FA2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:14:36.208 2025-09-14 08:14:36.220514 :CD375FA3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24764 pso_num=25 pso_serial#=228 2025-09-14 08:14:36.220640 :CD375FA4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24764 osp_idx=23 osp_ver=298336 osp_pg=0 (spawn #590597) 2025-09-14 08:14:36.220642 :CD375FA5:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:14:36.220642 :CD375FA6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=121 time=2223327518 2025-09-14 08:14:36.220643 :CD375FA7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:14:36.220643 :CD375FA8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:14:36.220644 :CD375FA9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:14:36.220644 :CD375FAA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:14:36.220644 :CD375FAB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:14:36.221186 :CD375FAC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:15:06.279029 :CD376A3D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:15:36.309233 :CD377732:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:15:36.298 2025-09-14 08:15:36.309235 :CD377733:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22464 pso_num=25 pso_serial#=229 2025-09-14 08:15:36.309371 :CD377734:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22464 osp_idx=23 osp_ver=298337 osp_pg=0 (spawn #590599) 2025-09-14 08:15:36.309371 :CD377735:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:15:36.309372 :CD377736:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=122 time=2223387612 2025-09-14 08:15:36.309373 :CD377737:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:15:36.309373 :CD377738:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:15:36.309373 :CD377739:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:15:36.309373 :CD37773A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:15:36.309374 :CD37773B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:15:36.309883 :CD37773C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:16:06.391083 :CD378138:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:16:36.412874 :CD378B72:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:16:36.401 2025-09-14 08:16:36.412877 :CD378B73:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24056 pso_num=25 pso_serial#=230 2025-09-14 08:16:36.413004 :CD378B74:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24056 osp_idx=23 osp_ver=298338 osp_pg=0 (spawn #590602) 2025-09-14 08:16:36.413004 :CD378B75:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:16:36.413005 :CD378B76:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=123 time=2223447705 2025-09-14 08:16:36.413005 :CD378B77:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:16:36.413006 :CD378B78:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:16:36.413006 :CD378B79:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:16:36.413006 :CD378B7A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:16:36.413007 :CD378B7B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:16:36.413506 :CD378B7C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:17:06.512666 :CD379515:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:17:36.509870 :CD379EB6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:17:36.499 2025-09-14 08:17:36.509872 :CD379EB7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25436 pso_num=25 pso_serial#=231 2025-09-14 08:17:36.510041 :CD379EB8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25436 osp_idx=23 osp_ver=298339 osp_pg=0 (spawn #590604) 2025-09-14 08:17:36.510042 :CD379EB9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:17:36.510043 :CD379EBA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=124 time=2223507815 2025-09-14 08:17:36.510043 :CD379EBB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:17:36.510044 :CD379EBC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:17:36.510044 :CD379EBD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:17:36.510044 :CD379EBE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:17:36.510045 :CD379EBF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:17:36.510533 :CD379EC0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:18:06.602803 :CD37A8B6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:18:36.603666 :CD37B284:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:18:36.592 2025-09-14 08:18:36.603668 :CD37B285:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24052 pso_num=25 pso_serial#=232 2025-09-14 08:18:36.603806 :CD37B286:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24052 osp_idx=23 osp_ver=298340 osp_pg=0 (spawn #590606) 2025-09-14 08:18:36.603807 :CD37B287:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:18:36.603807 :CD37B288:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=125 time=2223567908 2025-09-14 08:18:36.603807 :CD37B289:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:18:36.603808 :CD37B28A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:18:36.603808 :CD37B28B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:18:36.603809 :CD37B28C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:18:36.603809 :CD37B28D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:18:36.604289 :CD37B28E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:19:06.671277 :CD37BC84:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:19:36.716308 :CD37C65A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:19:36.705 2025-09-14 08:19:36.716310 :CD37C65B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24752 pso_num=25 pso_serial#=233 2025-09-14 08:19:36.716426 :CD37C65C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24752 osp_idx=23 osp_ver=298341 osp_pg=0 (spawn #590609) 2025-09-14 08:19:36.716427 :CD37C65D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:19:36.716427 :CD37C65E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=126 time=2223628018 2025-09-14 08:19:36.716428 :CD37C65F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:19:36.716428 :CD37C660:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:19:36.716428 :CD37C661:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:19:36.716429 :CD37C662:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:19:36.716429 :CD37C663:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:19:36.716914 :CD37C664:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:20:06.823027 :CD37D084:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:20:36.821401 :CD37DA98:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:20:36.809 2025-09-14 08:20:36.821403 :CD37DA99:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22396 pso_num=25 pso_serial#=234 2025-09-14 08:20:36.821525 :CD37DA9A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22396 osp_idx=23 osp_ver=298342 osp_pg=0 (spawn #590611) 2025-09-14 08:20:36.821525 :CD37DA9B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:20:36.821526 :CD37DA9C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=127 time=2223688112 2025-09-14 08:20:36.821526 :CD37DA9D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:20:36.821527 :CD37DA9E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:20:36.821527 :CD37DA9F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:20:36.821528 :CD37DAA0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:20:36.821528 :CD37DAA1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:20:36.821985 :CD37DAA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:21:06.930191 :CD37E469:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:21:36.928147 :CD37EE40:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:21:36.916 2025-09-14 08:21:36.928150 :CD37EE41:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24776 pso_num=25 pso_serial#=235 2025-09-14 08:21:36.928291 :CD37EE42:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24776 osp_idx=23 osp_ver=298343 osp_pg=0 (spawn #590613) 2025-09-14 08:21:36.928291 :CD37EE43:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:21:36.928292 :CD37EE44:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=128 time=2223748221 2025-09-14 08:21:36.928292 :CD37EE45:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:21:36.928293 :CD37EE46:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:21:36.928293 :CD37EE47:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:21:36.928294 :CD37EE48:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:21:36.928294 :CD37EE49:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:21:36.928825 :CD37EE4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:22:07.033626 :CD37F818:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:22:37.049223 :CD3801E9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:22:37.037 2025-09-14 08:22:37.049225 :CD3801EA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23136 pso_num=25 pso_serial#=236 2025-09-14 08:22:37.049348 :CD3801EB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23136 osp_idx=23 osp_ver=298344 osp_pg=0 (spawn #590615) 2025-09-14 08:22:37.049349 :CD3801EC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:22:37.049349 :CD3801ED:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=129 time=2223808346 2025-09-14 08:22:37.049350 :CD3801EE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:22:37.049350 :CD3801EF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:22:37.049350 :CD3801F0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:22:37.049351 :CD3801F1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:22:37.049351 :CD3801F2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:22:37.049819 :CD3801F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:23:07.146264 :CD380B85:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:23:22.117591 :CD3810CA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:23:22.105 2025-09-14 08:23:22.117594 :CD3810CB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24316 pso_num=25 pso_serial#=237 2025-09-14 08:23:22.117740 :CD3810CC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24316 osp_idx=23 osp_ver=298345 osp_pg=0 (spawn #590617) 2025-09-14 08:23:22.117740 :CD3810CD:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:23:22.117741 :CD3810CE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=130 time=2223853408 2025-09-14 08:23:22.117741 :CD3810CF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:23:22.117742 :CD3810D0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:23:22.117742 :CD3810D1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:23:22.117742 :CD3810D2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:23:22.117743 :CD3810D3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:23:22.118286 :CD3810D4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:23:37.115416 :CD38159B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-14 08:24:07.203905 :CD381F92:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:24:27.224567 :CD385D1D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:24:27.216 2025-09-14 08:24:27.224569 :CD385D1E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24744 pso_num=25 pso_serial#=238 2025-09-14 08:24:27.224745 :CD385D1F:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=24744 (legacy spawn) 2025-09-14 08:24:27.231183 :CD385D20: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 08:24:27.231468 :CD385D28: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 08:24:27.232279 :CD385D2A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:24:29.558744 :CD386113:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:24:29.549 2025-09-14 08:24:29.558746 :CD386114:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20784 pso_num=25 pso_serial#=239 2025-09-14 08:24:29.558901 :CD386115:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20784 osp_idx=23 osp_ver=298347 osp_pg=0 (spawn #590619) 2025-09-14 08:24:29.558902 :CD386116:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:24:29.558902 :CD386117:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=131 time=2223920862 2025-09-14 08:24:29.558903 :CD386118:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:24:29.558903 :CD386119:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:24:29.558903 :CD38611A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:24:29.558903 :CD38611B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:24:29.558904 :CD38611C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:24:29.560244 :CD38611D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:24:29.560288 :CD386123:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-09-14 08:24:29.684724 :CD386155:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-14 08:24:31.783337 :CD3861D5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-14 08:24:31.768 2025-09-14 08:24:31.783339 :CD3861D6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22940 pso_num=25 pso_serial#=240 2025-09-14 08:24:31.783513 :CD3861D7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22940 osp_idx=23 osp_ver=298348 osp_pg=0 (spawn #590621) 2025-09-14 08:24:31.783513 :CD3861D8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-14 08:24:31.783514 :CD3861D9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=132 time=2223923080 2025-09-14 08:24:31.783514 :CD3861DA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-14 08:24:31.783515 :CD3861DB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-14 08:24:31.783515 :CD3861DC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-14 08:24:31.783515 :CD3861DD:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-14 08:24:31.783515 :CD3861DE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-14 08:24:31.784120 :CD3861DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-09-14 08:24:31.784399 :CD3861E5:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=18 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: 22940, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de