Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250622082943\orcl_m002_17508_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250622082943\orcl_m002_17508_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:36380M/63366M, Ph+PgF:42610M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 17508, image: ORACLE.EXE (M002) *** 2025-06-22 08:29:43.830 *** SESSION ID:(201.40473) 2025-06-22 08:29:43.830 *** 2025-06-22 08:29:43.830 Process diagnostic dump for ORACLE.EXE (M002), OS id=17508, pid: 25, proc_ser: 78, sid: 201, sess_ser: 40473 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'db file sequential read' file#=0x2, block#=0x461a, blocks=0x1 wait_id=1589 seq_num=1590 snap_id=1 wait times: snap=0.005864 sec, exc=0.005864 sec, total=0.005864 sec wait times: max=infinite, heur=0.005864 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.000347 sec since current wait 0: waited for 'db file sequential read' file#=0x2, block#=0x467a, blocks=0x1 wait_id=1588 seq_num=1589 snap_id=1 wait times: snap=0.002850 sec, exc=0.002850 sec, total=0.002850 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000162 sec of elapsed time 1: waited for 'db file sequential read' file#=0x2, block#=0x4602, blocks=0x1 wait_id=1587 seq_num=1588 snap_id=1 wait times: snap=0.000425 sec, exc=0.000425 sec, total=0.000425 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000181 sec of elapsed time 2: waited for 'db file sequential read' file#=0x2, block#=0x46ca, blocks=0x1 wait_id=1586 seq_num=1587 snap_id=1 wait times: snap=0.000089 sec, exc=0.000089 sec, total=0.000089 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000385 sec of elapsed time 3: waited for 'db file sequential read' file#=0x2, block#=0x455a, blocks=0x1 wait_id=1585 seq_num=1586 snap_id=1 wait times: snap=0.005485 sec, exc=0.005485 sec, total=0.005485 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000163 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x49f2, blocks=0x1 wait_id=1584 seq_num=1585 snap_id=1 wait times: snap=0.000048 sec, exc=0.000048 sec, total=0.000048 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000139 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x49e2, blocks=0x1 wait_id=1583 seq_num=1584 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.000133 sec of elapsed time 6: waited for 'db file sequential read' file#=0x2, block#=0x49d2, blocks=0x1 wait_id=1582 seq_num=1583 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.000138 sec of elapsed time 7: waited for 'db file sequential read' file#=0x2, block#=0x49c2, blocks=0x1 wait_id=1581 seq_num=1582 snap_id=1 wait times: snap=0.000052 sec, exc=0.000052 sec, total=0.000052 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000152 sec of elapsed time 8: waited for 'db file sequential read' file#=0x2, block#=0x49b2, blocks=0x1 wait_id=1580 seq_num=1581 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.000288 sec of elapsed time 9: waited for 'db file sequential read' file#=0x2, block#=0x499a, blocks=0x1 wait_id=1579 seq_num=1580 snap_id=1 wait times: snap=0.001397 sec, exc=0.001397 sec, total=0.001397 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000334 sec of elapsed time Sampled Session History of session 201 serial 40473 --------------------------------------------------- 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:29:43] idle wait at each sample [session created at: 08:29:43] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-22 08:29:43.830 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 17508, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-22 08:16:47.663544 :A806096B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:16:47.663545 :A806096C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=100 time=3555950844 2025-06-22 08:16:47.663545 :A806096D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:16:47.663546 :A806096E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:16:47.663546 :A806096F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:16:47.663546 :A8060970:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:16:47.663547 :A8060971:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:16:47.664032 :A8060972: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-06-22 08:17:17.716615 :A80612FD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:17:47.729947 :A8061C8D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:17:47.719 2025-06-22 08:17:47.729949 :A8061C8E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16700 pso_num=25 pso_serial#=63 2025-06-22 08:17:47.730090 :A8061C8F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16700 osp_idx=23 osp_ver=165670 osp_pg=0 (spawn #310599) 2025-06-22 08:17:47.730090 :A8061C90:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:17:47.730091 :A8061C91:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=101 time=3556010907 2025-06-22 08:17:47.730091 :A8061C92:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:17:47.730092 :A8061C93:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:17:47.730092 :A8061C94:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:17:47.730093 :A8061C95:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:17:47.730093 :A8061C96:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:17:47.730587 :A8061C97: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-06-22 08:18:17.819043 :A80626CC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:18:47.822278 :A80630A1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:18:47.811 2025-06-22 08:18:47.822281 :A80630A2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14064 pso_num=25 pso_serial#=64 2025-06-22 08:18:47.822417 :A80630A3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14064 osp_idx=23 osp_ver=165671 osp_pg=0 (spawn #310602) 2025-06-22 08:18:47.822418 :A80630A4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:18:47.822418 :A80630A5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=102 time=3556071000 2025-06-22 08:18:47.822419 :A80630A6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:18:47.822419 :A80630A7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:18:47.822419 :A80630A8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:18:47.822420 :A80630A9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:18:47.822420 :A80630AA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:18:47.822909 :A80630AB: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-06-22 08:19:17.909799 :A8063A45:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:19:47.928669 :A80643FE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:19:47.918 2025-06-22 08:19:47.928671 :A80643FF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17628 pso_num=25 pso_serial#=65 2025-06-22 08:19:47.928810 :A8064400:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17628 osp_idx=23 osp_ver=165672 osp_pg=0 (spawn #310604) 2025-06-22 08:19:47.928811 :A8064401:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:19:47.928812 :A8064402:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=103 time=3556131110 2025-06-22 08:19:47.928812 :A8064403:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:19:47.928813 :A8064404:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:19:47.928813 :A8064405:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:19:47.928814 :A8064406:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:19:47.928814 :A8064407:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:19:47.929295 :A8064408: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-06-22 08:20:18.008241 :A8064E11:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:20:48.005258 :A80657C0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:20:47.994 2025-06-22 08:20:48.005261 :A80657C1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16544 pso_num=25 pso_serial#=66 2025-06-22 08:20:48.005394 :A80657C2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16544 osp_idx=23 osp_ver=165673 osp_pg=0 (spawn #310606) 2025-06-22 08:20:48.005395 :A80657C3:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:20:48.005395 :A80657C4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=104 time=3556191188 2025-06-22 08:20:48.005395 :A80657C5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:20:48.005396 :A80657C6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:20:48.005396 :A80657C7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:20:48.005397 :A80657C8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:20:48.005397 :A80657C9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:20:48.005886 :A80657CA: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-06-22 08:21:18.056252 :A8066167:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:21:48.096111 :A8066AE4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:21:48.084 2025-06-22 08:21:48.096113 :A8066AE5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17176 pso_num=25 pso_serial#=67 2025-06-22 08:21:48.096239 :A8066AE6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17176 osp_idx=23 osp_ver=165674 osp_pg=0 (spawn #310608) 2025-06-22 08:21:48.096239 :A8066AE7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:21:48.096240 :A8066AE8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=105 time=3556251282 2025-06-22 08:21:48.096240 :A8066AE9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:21:48.096241 :A8066AEA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:21:48.096241 :A8066AEB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:21:48.096241 :A8066AEC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:21:48.096241 :A8066AED:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:21:48.096728 :A8066AEE: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-06-22 08:22:18.180076 :A8067480:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:22:48.179074 :A8067E1C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:22:48.168 2025-06-22 08:22:48.179076 :A8067E1D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16324 pso_num=25 pso_serial#=68 2025-06-22 08:22:48.179272 :A8067E1E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16324 osp_idx=23 osp_ver=165675 osp_pg=0 (spawn #310610) 2025-06-22 08:22:48.179273 :A8067E1F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:22:48.179273 :A8067E20:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=106 time=3556311360 2025-06-22 08:22:48.179273 :A8067E21:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:22:48.179274 :A8067E22:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:22:48.179274 :A8067E23:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:22:48.179275 :A8067E24:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:22:48.179277 :A8067E25:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:22:48.179765 :A8067E26: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-06-22 08:23:18.264883 :A8068821:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:23:48.268009 :A80691ED:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:23:48.256 2025-06-22 08:23:48.268011 :A80691EE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16164 pso_num=25 pso_serial#=69 2025-06-22 08:23:48.268147 :A80691EF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16164 osp_idx=23 osp_ver=165676 osp_pg=0 (spawn #310613) 2025-06-22 08:23:48.268147 :A80691F0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:23:48.268148 :A80691F1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=107 time=3556371454 2025-06-22 08:23:48.268148 :A80691F2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:23:48.268148 :A80691F3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:23:48.268149 :A80691F4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:23:48.268149 :A80691F5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:23:48.268149 :A80691F6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:23:48.268674 :A80691F7: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-06-22 08:24:13.283242 :A80699E0: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-06-22 08:24:43.383223 :A806A41B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:24:48.336511 :A806A5DE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:24:48.325 2025-06-22 08:24:48.336512 :A806A5DF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17396 pso_num=25 pso_serial#=70 2025-06-22 08:24:48.336646 :A806A5E0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17396 osp_idx=23 osp_ver=165677 osp_pg=0 (spawn #310615) 2025-06-22 08:24:48.336647 :A806A5E1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:24:48.336647 :A806A5E2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=108 time=3556431516 2025-06-22 08:24:48.336648 :A806A5E3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:24:48.336648 :A806A5E4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:24:48.336649 :A806A5E5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:24:48.336649 :A806A5E6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:24:48.336649 :A806A5E7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:24:48.337127 :A806A5E8: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-06-22 08:25:18.378106 :A806B0AB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:25:48.412944 :A806BAB8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:25:48.401 2025-06-22 08:25:48.412946 :A806BAB9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16840 pso_num=25 pso_serial#=71 2025-06-22 08:25:48.413077 :A806BABA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16840 osp_idx=23 osp_ver=165678 osp_pg=0 (spawn #310618) 2025-06-22 08:25:48.413078 :A806BABB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:25:48.413078 :A806BABC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=109 time=3556491594 2025-06-22 08:25:48.413079 :A806BABD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:25:48.413079 :A806BABE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:25:48.413079 :A806BABF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:25:48.413080 :A806BAC0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:25:48.413080 :A806BAC1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:25:48.413548 :A806BAC2: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-06-22 08:26:18.488588 :A806C45B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:26:48.531438 :A806CE3F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:26:48.528 2025-06-22 08:26:48.531440 :A806CE40:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17432 pso_num=25 pso_serial#=72 2025-06-22 08:26:48.531571 :A806CE41:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17432 osp_idx=23 osp_ver=165679 osp_pg=0 (spawn #310620) 2025-06-22 08:26:48.531571 :A806CE42:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:26:48.531572 :A806CE43:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=110 time=3556551704 2025-06-22 08:26:48.531572 :A806CE44:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:26:48.531573 :A806CE45:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:26:48.531573 :A806CE46:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:26:48.531573 :A806CE47:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:26:48.531574 :A806CE48:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:26:48.532053 :A806CE49: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-06-22 08:27:18.618199 :A806D7F4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:27:48.624073 :A806E193:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:27:48.613 2025-06-22 08:27:48.624075 :A806E194:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16048 pso_num=25 pso_serial#=73 2025-06-22 08:27:48.624209 :A806E195:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16048 osp_idx=23 osp_ver=165680 osp_pg=0 (spawn #310622) 2025-06-22 08:27:48.624210 :A806E196:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:27:48.624210 :A806E197:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=111 time=3556611813 2025-06-22 08:27:48.624210 :A806E198:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:27:48.624211 :A806E199:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:27:48.624211 :A806E19A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:27:48.624212 :A806E19B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:27:48.624212 :A806E19C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:27:48.624687 :A806E19D: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-06-22 08:28:18.731362 :A806EB9F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:28:48.718446 :A806F59E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:28:48.707 2025-06-22 08:28:48.718448 :A806F59F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16668 pso_num=25 pso_serial#=74 2025-06-22 08:28:48.718585 :A806F5A0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16668 osp_idx=23 osp_ver=165681 osp_pg=0 (spawn #310625) 2025-06-22 08:28:48.718586 :A806F5A1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:28:48.718587 :A806F5A2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=112 time=3556671907 2025-06-22 08:28:48.718587 :A806F5A3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:28:48.718588 :A806F5A4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:28:48.718588 :A806F5A5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:28:48.718588 :A806F5A6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:28:48.718589 :A806F5A7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:28:48.719123 :A806F5A8: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-06-22 08:29:18.811823 :A806FF26:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:29:40.971668 :A8074055:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:29:40.961 2025-06-22 08:29:40.971671 :A8074056:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17100 pso_num=25 pso_serial#=75 2025-06-22 08:29:40.971839 :A8074057:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17100 osp_idx=23 osp_ver=165682 osp_pg=0 (spawn #310627) 2025-06-22 08:29:40.971840 :A8074058:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:29:40.971840 :A8074059:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=113 time=3556724157 2025-06-22 08:29:40.971841 :A807405A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:29:40.971841 :A807405B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:29:40.971841 :A807405C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:29:40.971842 :A807405D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:29:40.971842 :A807405E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:29:40.973212 :A807405F: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-06-22 08:29:40.973258 :A8074065: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-06-22 08:29:41.072250 :A80740A3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:29:42.408249 :A8074105:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:29:42.398 2025-06-22 08:29:42.408251 :A8074106:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17496 pso_num=25 pso_serial#=76 2025-06-22 08:29:42.408388 :A8074107:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=17496 (legacy spawn) 2025-06-22 08:29:42.415027 :A8074108: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-06-22 08:29:42.415185 :A8074111: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-06-22 08:29:42.415978 :A8074112:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:29:42.424752 :A8074115:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:29:42.414 2025-06-22 08:29:42.424754 :A8074116:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16896 pso_num=25 pso_serial#=77 2025-06-22 08:29:42.424892 :A8074117:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=16896 (legacy spawn) 2025-06-22 08:29:42.431437 :A8074118: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-06-22 08:29:42.431596 :A8074121: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-06-22 08:29:42.432406 :A8074122:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-22 08:29:43.209786 :A80741B6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-22 08:29:43.195 2025-06-22 08:29:43.209788 :A80741B7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17508 pso_num=25 pso_serial#=78 2025-06-22 08:29:43.209923 :A80741B8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17508 osp_idx=23 osp_ver=165685 osp_pg=0 (spawn #310629) 2025-06-22 08:29:43.209923 :A80741B9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-22 08:29:43.209924 :A80741BA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=114 time=3556726391 2025-06-22 08:29:43.209924 :A80741BB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-22 08:29:43.209924 :A80741BC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-22 08:29:43.209925 :A80741BD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-22 08:29:43.209925 :A80741BE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-22 08:29:43.209925 :A80741BF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-22 08:29:43.210406 :A80741C0: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-06-22 08:29:43.210455 :A80741C6: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: 17508, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de