Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250510082513\orcl_m002_10780_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250510082513\orcl_m002_10780_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:37490M/63366M, Ph+PgF:44845M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 10780, image: ORACLE.EXE (M002) *** 2025-05-10 08:25:13.345 *** SESSION ID:(201.58023) 2025-05-10 08:25:13.345 *** 2025-05-10 08:25:13.345 Process diagnostic dump for ORACLE.EXE (M002), OS id=10780, pid: 25, proc_ser: 40, sid: 201, sess_ser: 58023 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: Not in wait; last wait ended 0.000202 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000227 sec since last wait 0: waited for 'db file sequential read' file#=0x2, block#=0xea42, blocks=0x1 wait_id=1718 seq_num=1719 snap_id=1 wait times: snap=0.002140 sec, exc=0.002140 sec, total=0.002140 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000165 sec of elapsed time 1: waited for 'db file sequential read' file#=0x2, block#=0x85b2, blocks=0x1 wait_id=1717 seq_num=1718 snap_id=1 wait times: snap=0.000083 sec, exc=0.000083 sec, total=0.000083 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000339 sec of elapsed time 2: waited for 'db file sequential read' file#=0x2, block#=0x844a, blocks=0x1 wait_id=1716 seq_num=1717 snap_id=1 wait times: snap=0.005135 sec, exc=0.005135 sec, total=0.005135 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000263 sec of elapsed time 3: waited for 'db file sequential read' file#=0x2, block#=0x7ffa, blocks=0x1 wait_id=1715 seq_num=1716 snap_id=1 wait times: snap=0.001999 sec, exc=0.001999 sec, total=0.001999 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000290 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x7fda, blocks=0x1 wait_id=1714 seq_num=1715 snap_id=1 wait times: snap=0.000057 sec, exc=0.000057 sec, total=0.000057 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000149 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x7fea, blocks=0x1 wait_id=1713 seq_num=1714 snap_id=1 wait times: snap=0.000047 sec, exc=0.000047 sec, total=0.000047 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000133 sec of elapsed time 6: waited for 'db file sequential read' file#=0x2, block#=0x8022, blocks=0x1 wait_id=1712 seq_num=1713 snap_id=1 wait times: snap=0.000051 sec, exc=0.000051 sec, total=0.000051 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000269 sec of elapsed time 7: waited for 'db file sequential read' file#=0x2, block#=0x8042, blocks=0x1 wait_id=1711 seq_num=1712 snap_id=1 wait times: snap=0.000049 sec, exc=0.000049 sec, total=0.000049 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000140 sec of elapsed time 8: waited for 'db file sequential read' file#=0x2, block#=0x8032, blocks=0x1 wait_id=1710 seq_num=1711 snap_id=1 wait times: snap=0.000050 sec, exc=0.000050 sec, total=0.000050 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000143 sec of elapsed time 9: waited for 'db file sequential read' file#=0x2, block#=0x78d2, blocks=0x1 wait_id=1719 seq_num=1720 snap_id=1 wait times: snap=0.000058 sec, exc=0.000058 sec, total=0.000058 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000315 sec of elapsed time Sampled Session History of session 201 serial 58023 --------------------------------------------------- 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:25:13] waited for 'db file sequential read', seq_num: 1578 p1: 'file#'=0x2 p2: 'block#'=0x4472 p3: 'blocks'=0x1 time_waited: >= 0 sec (still in wait) [1 sample, 08:25:12] idle wait at each sample [session created at: 08:25:12] --------------------------------------------------- Sampled Session History Summary: longest_non_idle_wait: 'db file sequential read' [1 sample, 08:25:13 ] time_waited: >= 0 sec (still in wait) --------------------------------------------------- ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-10 08:25:13.345 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 10780, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-10 08:11:26.552673 :9522DE1C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12000 osp_idx=23 osp_ver=84939 osp_pg=0 (spawn #167114) 2025-05-10 08:11:26.552674 :9522DE1D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:11:26.552674 :9522DE1E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=223 time=4135463718 2025-05-10 08:11:26.552675 :9522DE1F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:11:26.552675 :9522DE20:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:11:26.552676 :9522DE21:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:11:26.552676 :9522DE22:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:11:26.552676 :9522DE23:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:11:26.553162 :9522DE24: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-05-10 08:11:56.646660 :9522E7CC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:12:26.655629 :9522F14E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:12:26.644 2025-05-10 08:12:26.655631 :9522F14F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10096 pso_num=25 pso_serial#=26 2025-05-10 08:12:26.655763 :9522F150:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10096 osp_idx=23 osp_ver=84940 osp_pg=0 (spawn #167116) 2025-05-10 08:12:26.655763 :9522F151:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:12:26.655764 :9522F152:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=224 time=4135523812 2025-05-10 08:12:26.655764 :9522F153:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:12:26.655764 :9522F154:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:12:26.655765 :9522F155:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:12:26.655765 :9522F156:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:12:26.655765 :9522F157:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:12:26.656240 :9522F158: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-05-10 08:12:56.735789 :9522FB15:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:13:26.706629 :952304B6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:13:26.695 2025-05-10 08:13:26.706631 :952304B7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12176 pso_num=25 pso_serial#=27 2025-05-10 08:13:26.706777 :952304B8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12176 osp_idx=23 osp_ver=84941 osp_pg=0 (spawn #167118) 2025-05-10 08:13:26.706777 :952304B9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:13:26.706778 :952304BA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=225 time=4135583859 2025-05-10 08:13:26.706778 :952304BB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:13:26.706779 :952304BC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:13:26.706779 :952304BD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:13:26.706779 :952304BE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:13:26.706780 :952304BF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:13:26.707278 :952304C0: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-05-10 08:13:56.796294 :95230EB2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:14:26.790870 :95231865:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:14:26.779 2025-05-10 08:14:26.790872 :95231866:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7552 pso_num=25 pso_serial#=28 2025-05-10 08:14:26.791013 :95231867:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7552 osp_idx=23 osp_ver=84942 osp_pg=0 (spawn #167121) 2025-05-10 08:14:26.791014 :95231868:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:14:26.791015 :95231869:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=226 time=4135643953 2025-05-10 08:14:26.791015 :9523186A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:14:26.791015 :9523186B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:14:26.791016 :9523186C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:14:26.791016 :9523186D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:14:26.791017 :9523186E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:14:26.791509 :9523186F: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-05-10 08:14:56.861797 :95232301:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:15:26.867649 :95232CA3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:15:26.857 2025-05-10 08:15:26.867651 :95232CA4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11512 pso_num=25 pso_serial#=29 2025-05-10 08:15:26.867785 :95232CA5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11512 osp_idx=23 osp_ver=84943 osp_pg=0 (spawn #167123) 2025-05-10 08:15:26.867785 :95232CA6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:15:26.867785 :95232CA7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=227 time=4135704031 2025-05-10 08:15:26.867786 :95232CA8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:15:26.867786 :95232CA9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:15:26.867786 :95232CAA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:15:26.867787 :95232CAB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:15:26.867787 :95232CAC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:15:26.868257 :95232CAD: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-05-10 08:15:56.951902 :95233907:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:16:26.956390 :952342A2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:16:26.945 2025-05-10 08:16:26.956391 :952342A3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9460 pso_num=25 pso_serial#=30 2025-05-10 08:16:26.956521 :952342A4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9460 osp_idx=23 osp_ver=84944 osp_pg=0 (spawn #167125) 2025-05-10 08:16:26.956522 :952342A5:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:16:26.956522 :952342A6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=228 time=4135764109 2025-05-10 08:16:26.956522 :952342A7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:16:26.956523 :952342A8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:16:26.956523 :952342A9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:16:26.956524 :952342AA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:16:26.956524 :952342AB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:16:26.956995 :952342AC: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-05-10 08:16:57.042056 :95234C5D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:17:27.039360 :9523563B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:17:27.028 2025-05-10 08:17:27.039362 :9523563C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11648 pso_num=25 pso_serial#=31 2025-05-10 08:17:27.039493 :9523563D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11648 osp_idx=23 osp_ver=84945 osp_pg=0 (spawn #167127) 2025-05-10 08:17:27.039493 :9523563E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:17:27.039493 :9523563F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=229 time=4135824203 2025-05-10 08:17:27.039494 :95235640:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:17:27.039494 :95235641:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:17:27.039495 :95235642:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:17:27.039495 :95235643:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:17:27.039495 :95235644:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:17:27.040044 :95235645: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-05-10 08:17:57.138164 :95236044:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:18:27.157636 :95236A18:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:18:27.147 2025-05-10 08:18:27.157638 :95236A19:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12796 pso_num=25 pso_serial#=32 2025-05-10 08:18:27.157776 :95236A1A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12796 osp_idx=23 osp_ver=84946 osp_pg=0 (spawn #167129) 2025-05-10 08:18:27.157779 :95236A1B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:18:27.157779 :95236A1C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=230 time=4135884312 2025-05-10 08:18:27.157779 :95236A1D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:18:27.157780 :95236A1E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:18:27.157780 :95236A1F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:18:27.157780 :95236A20:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:18:27.157780 :95236A21:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:18:27.158256 :95236A22: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-05-10 08:18:57.278863 :952373B3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:19:22.224042 :95237BE9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:19:22.213 2025-05-10 08:19:22.224044 :95237BEA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8392 pso_num=25 pso_serial#=33 2025-05-10 08:19:22.224173 :95237BEB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8392 osp_idx=23 osp_ver=84947 osp_pg=0 (spawn #167131) 2025-05-10 08:19:22.224174 :95237BEC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:19:22.224174 :95237BED:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=231 time=4135939390 2025-05-10 08:19:22.224175 :95237BEE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:19:22.224175 :95237BEF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:19:22.224176 :95237BF0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:19:22.224176 :95237BF1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:19:22.224176 :95237BF2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:19:22.224647 :95237BF3: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-05-10 08:19:27.229264 :95237D69: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-05-10 08:19:57.353401 :9523881B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:20:27.312154 :952391D8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:20:27.301 2025-05-10 08:20:27.312156 :952391D9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2840 pso_num=25 pso_serial#=34 2025-05-10 08:20:27.312283 :952391DA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2840 osp_idx=23 osp_ver=84948 osp_pg=0 (spawn #167135) 2025-05-10 08:20:27.312283 :952391DB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:20:27.312284 :952391DC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=232 time=4136004468 2025-05-10 08:20:27.312284 :952391DD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:20:27.312285 :952391DE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:20:27.312285 :952391DF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:20:27.312285 :952391E0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:20:27.312286 :952391E1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:20:27.312764 :952391E2: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-05-10 08:20:57.404304 :95239BC4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:21:27.387355 :9523A56A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:21:27.376 2025-05-10 08:21:27.387357 :9523A56B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7888 pso_num=25 pso_serial#=35 2025-05-10 08:21:27.387496 :9523A56C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7888 osp_idx=23 osp_ver=84949 osp_pg=0 (spawn #167137) 2025-05-10 08:21:27.387497 :9523A56D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:21:27.387497 :9523A56E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=233 time=4136064546 2025-05-10 08:21:27.387498 :9523A56F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:21:27.387498 :9523A570:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:21:27.387499 :9523A571:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:21:27.387499 :9523A572:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:21:27.387499 :9523A573:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:21:27.387981 :9523A574: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-05-10 08:21:57.462788 :9523AF38:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:22:27.501265 :9523B8E9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:22:27.490 2025-05-10 08:22:27.501267 :9523B8EA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8172 pso_num=25 pso_serial#=36 2025-05-10 08:22:27.501397 :9523B8EB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8172 osp_idx=23 osp_ver=84950 osp_pg=0 (spawn #167139) 2025-05-10 08:22:27.501397 :9523B8EC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:22:27.501398 :9523B8ED:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=234 time=4136124656 2025-05-10 08:22:27.501398 :9523B8EE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:22:27.501399 :9523B8EF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:22:27.501399 :9523B8F0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:22:27.501399 :9523B8F1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:22:27.501400 :9523B8F2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:22:27.501909 :9523B8F3: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-05-10 08:22:57.583902 :9523C2BE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:23:27.591512 :9523CC58:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:23:27.580 2025-05-10 08:23:27.591514 :9523CC59:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=1156 pso_num=25 pso_serial#=37 2025-05-10 08:23:27.591649 :9523CC5A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=1156 osp_idx=23 osp_ver=84951 osp_pg=0 (spawn #167141) 2025-05-10 08:23:27.591650 :9523CC5B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:23:27.591650 :9523CC5C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=235 time=4136184750 2025-05-10 08:23:27.591650 :9523CC5D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:23:27.591651 :9523CC5E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:23:27.591651 :9523CC5F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:23:27.591651 :9523CC60:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:23:27.591652 :9523CC61:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:23:27.592147 :9523CC62: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-05-10 08:23:57.697042 :9523D63D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:24:27.677387 :9523E03E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:24:27.666 2025-05-10 08:24:27.677390 :9523E03F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12388 pso_num=25 pso_serial#=38 2025-05-10 08:24:27.677524 :9523E040:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12388 osp_idx=23 osp_ver=84952 osp_pg=0 (spawn #167144) 2025-05-10 08:24:27.677525 :9523E041:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:24:27.677525 :9523E042:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=236 time=4136244843 2025-05-10 08:24:27.677526 :9523E043:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:24:27.677526 :9523E044:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:24:27.677526 :9523E045:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:24:27.677527 :9523E046:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:24:27.677527 :9523E047:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:24:27.678002 :9523E048: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-05-10 08:24:57.758546 :9523EAA9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:25:10.306883 :9524286A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:25:10.303 2025-05-10 08:25:10.306885 :9524286B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12704 pso_num=25 pso_serial#=39 2025-05-10 08:25:10.307069 :9524286C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12704 osp_idx=23 osp_ver=84953 osp_pg=0 (spawn #167146) 2025-05-10 08:25:10.307070 :9524286D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:25:10.307071 :9524286E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=237 time=4136287453 2025-05-10 08:25:10.307071 :9524286F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:25:10.307071 :95242870:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:25:10.307072 :95242871:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:25:10.307072 :95242872:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:25:10.307073 :95242873:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:25:10.307955 :95242874: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-05-10 08:25:10.308004 :9524287A: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-05-10 08:25:10.406169 :952428BC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-10 08:25:12.527551 :952429DB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-10 08:25:12.521 2025-05-10 08:25:12.527554 :952429DC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10780 pso_num=25 pso_serial#=40 2025-05-10 08:25:12.527685 :952429DD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10780 osp_idx=23 osp_ver=84954 osp_pg=0 (spawn #167148) 2025-05-10 08:25:12.527686 :952429DE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-10 08:25:12.527686 :952429DF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=238 time=4136289687 2025-05-10 08:25:12.527687 :952429E0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-10 08:25:12.527687 :952429E1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-10 08:25:12.527688 :952429E2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-10 08:25:12.527688 :952429E3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-10 08:25:12.527688 :952429E4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-10 08:25:12.528177 :952429E5: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-05-10 08:25:12.528222 :952429EB: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: 10780, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de