Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250617082653\orcl_m002_17320_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250617082653\orcl_m002_17320_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:36575M/63366M, Ph+PgF:42975M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 17320, image: ORACLE.EXE (M002) *** 2025-06-17 08:26:53.245 *** SESSION ID:(201.27975) 2025-06-17 08:26:53.245 *** 2025-06-17 08:26:53.245 Process diagnostic dump for ORACLE.EXE (M002), OS id=17320, pid: 25, proc_ser: 199, sid: 201, sess_ser: 27975 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'db file sequential read' file#=0x2, block#=0x3eea, blocks=0x1 wait_id=1519 seq_num=1520 snap_id=1 wait times: snap=0.001183 sec, exc=0.001183 sec, total=0.001183 sec wait times: max=infinite, heur=0.001183 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.000143 sec since current wait 0: waited for 'db file sequential read' file#=0x2, block#=0x3eca, blocks=0x1 wait_id=1518 seq_num=1519 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.000139 sec of elapsed time 1: waited for 'db file sequential read' file#=0x2, block#=0x3eb2, blocks=0x1 wait_id=1517 seq_num=1518 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.000139 sec of elapsed time 2: waited for 'db file sequential read' file#=0x2, block#=0x3e8a, blocks=0x1 wait_id=1516 seq_num=1517 snap_id=1 wait times: snap=0.000123 sec, exc=0.000123 sec, total=0.000123 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000185 sec of elapsed time 3: waited for 'db file sequential read' file#=0x2, block#=0x3e6a, blocks=0x1 wait_id=1515 seq_num=1516 snap_id=1 wait times: snap=0.001447 sec, exc=0.001447 sec, total=0.001447 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000142 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x3e4a, blocks=0x1 wait_id=1514 seq_num=1515 snap_id=1 wait times: snap=0.000113 sec, exc=0.000113 sec, total=0.000113 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000136 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x3e2a, blocks=0x1 wait_id=1513 seq_num=1514 snap_id=1 wait times: snap=0.000115 sec, exc=0.000115 sec, total=0.000115 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000139 sec of elapsed time 6: waited for 'db file sequential read' file#=0x2, block#=0x3de2, blocks=0x1 wait_id=1512 seq_num=1513 snap_id=1 wait times: snap=0.000422 sec, exc=0.000422 sec, total=0.000422 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000140 sec of elapsed time 7: waited for 'db file sequential read' file#=0x2, block#=0x3dba, blocks=0x1 wait_id=1511 seq_num=1512 snap_id=1 wait times: snap=0.000098 sec, exc=0.000098 sec, total=0.000098 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000208 sec of elapsed time 8: waited for 'db file sequential read' file#=0x2, block#=0x3daa, blocks=0x1 wait_id=1510 seq_num=1511 snap_id=1 wait times: snap=0.000150 sec, exc=0.000150 sec, total=0.000150 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000216 sec of elapsed time 9: waited for 'db file sequential read' file#=0x2, block#=0x3d62, blocks=0x1 wait_id=1509 seq_num=1510 snap_id=1 wait times: snap=0.000449 sec, exc=0.000449 sec, total=0.000449 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000326 sec of elapsed time Sampled Session History of session 201 serial 27975 --------------------------------------------------- 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:26:53] idle wait at each sample [session created at: 08:26:52] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-17 08:26:53.245 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 17320, M002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-17 08:16:13.583678 :A5D23E31: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-17 08:16:43.707923 :A5D24AF2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:17:13.724578 :A5D254BD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:17:13.719 2025-06-17 08:17:13.724581 :A5D254BE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17316 pso_num=25 pso_serial#=183 2025-06-17 08:17:13.724701 :A5D254BF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17316 osp_idx=23 osp_ver=159925 osp_pg=0 (spawn #293924) 2025-06-17 08:17:13.724701 :A5D254C0: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-17 08:17:13.724702 :A5D254C1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=213 time=3123976907 2025-06-17 08:17:13.724702 :A5D254C2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:17:13.724703 :A5D254C3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:17:13.724703 :A5D254C4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:17:13.724703 :A5D254C5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:17:13.724705 :A5D254C6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:17:13.725179 :A5D254C7: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-17 08:17:43.806372 :A5D25EF7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:18:13.810702 :A5D268D4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:18:13.799 2025-06-17 08:18:13.810704 :A5D268D5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16112 pso_num=25 pso_serial#=184 2025-06-17 08:18:13.810836 :A5D268D6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16112 osp_idx=23 osp_ver=159926 osp_pg=0 (spawn #293926) 2025-06-17 08:18:13.810837 :A5D268D7: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-17 08:18:13.810838 :A5D268D8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=214 time=3124037000 2025-06-17 08:18:13.810838 :A5D268D9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:18:13.810838 :A5D268DA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:18:13.810839 :A5D268DB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:18:13.810839 :A5D268DC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:18:13.810839 :A5D268DD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:18:13.811304 :A5D268DE: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-17 08:18:43.860122 :A5D272EE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:19:13.885301 :A5D27CE9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:19:13.874 2025-06-17 08:19:13.885303 :A5D27CEA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17020 pso_num=25 pso_serial#=185 2025-06-17 08:19:13.885441 :A5D27CEB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17020 osp_idx=23 osp_ver=159927 osp_pg=0 (spawn #293928) 2025-06-17 08:19:13.885442 :A5D27CEC: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-17 08:19:13.885442 :A5D27CED:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=215 time=3124097063 2025-06-17 08:19:13.885443 :A5D27CEE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:19:13.885443 :A5D27CEF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:19:13.885443 :A5D27CF0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:19:13.885444 :A5D27CF1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:19:13.885444 :A5D27CF2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:19:13.885925 :A5D27CF3: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-17 08:19:43.946481 :A5D2873E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:20:13.969060 :A5D2911C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:20:13.958 2025-06-17 08:20:13.969062 :A5D2911D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15816 pso_num=25 pso_serial#=186 2025-06-17 08:20:13.969199 :A5D2911E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15816 osp_idx=23 osp_ver=159928 osp_pg=0 (spawn #293930) 2025-06-17 08:20:13.969199 :A5D2911F: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-17 08:20:13.969199 :A5D29120:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=216 time=3124157157 2025-06-17 08:20:13.969200 :A5D29121:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:20:13.969200 :A5D29122:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:20:13.969201 :A5D29123:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:20:13.969201 :A5D29124:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:20:13.969201 :A5D29125:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:20:13.969704 :A5D29126: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-17 08:20:44.064708 :A5D29AEF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:21:14.057202 :A5D2A4C3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:21:14.046 2025-06-17 08:21:14.057204 :A5D2A4C4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12612 pso_num=25 pso_serial#=187 2025-06-17 08:21:14.057348 :A5D2A4C5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12612 osp_idx=23 osp_ver=159929 osp_pg=0 (spawn #293933) 2025-06-17 08:21:14.057348 :A5D2A4C6: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-17 08:21:14.057349 :A5D2A4C7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=217 time=3124217235 2025-06-17 08:21:14.057349 :A5D2A4C8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:21:14.057349 :A5D2A4C9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:21:14.057350 :A5D2A4CA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:21:14.057350 :A5D2A4CB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:21:14.057351 :A5D2A4CC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:21:14.057841 :A5D2A4CD: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-17 08:21:44.158512 :A5D2AF0C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:22:14.149603 :A5D2B917:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:22:14.137 2025-06-17 08:22:14.149605 :A5D2B918:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15916 pso_num=25 pso_serial#=188 2025-06-17 08:22:14.149729 :A5D2B919:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15916 osp_idx=23 osp_ver=159930 osp_pg=0 (spawn #293935) 2025-06-17 08:22:14.149730 :A5D2B91A: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-17 08:22:14.149730 :A5D2B91B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=218 time=3124277329 2025-06-17 08:22:14.149731 :A5D2B91C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:22:14.149731 :A5D2B91D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:22:14.149732 :A5D2B91E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:22:14.149732 :A5D2B91F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:22:14.149733 :A5D2B920:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:22:14.150261 :A5D2B921: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-17 08:22:44.177528 :A5D2C334:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:23:14.223994 :A5D2CD1D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:23:14.213 2025-06-17 08:23:14.223996 :A5D2CD1E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12744 pso_num=25 pso_serial#=189 2025-06-17 08:23:14.224134 :A5D2CD1F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12744 osp_idx=23 osp_ver=159931 osp_pg=0 (spawn #293937) 2025-06-17 08:23:14.224135 :A5D2CD20: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-17 08:23:14.224135 :A5D2CD21:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=219 time=3124337407 2025-06-17 08:23:14.224136 :A5D2CD22:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:23:14.224136 :A5D2CD23:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:23:14.224136 :A5D2CD24:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:23:14.224137 :A5D2CD25:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:23:14.224137 :A5D2CD26:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:23:14.224608 :A5D2CD27: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-17 08:23:39.248341 :A5D2D584: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-17 08:23:39.248373*:A5D2D585:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BDBB58 estart=1750119818 eid=16913463 ctx=0x000000077BD98A08 cwh=0x0000000026B901B0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-17 08:23:39.248373*:A5D2D586:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BDBB58 curCtx=0x0000000026B9F708 pubTabIdxCnt=0 2025-06-17 08:23:39.248373*:A5D2D587:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BDBB58 2025-06-17 08:23:39.248373*:A5D2D588:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BDBB58 2025-06-17 08:23:39.248373*:A5D2D589:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BDBB58 curCtx=0x0000000026B9F708 xsc->flg4=65792 flags=2 2025-06-17 08:23:39.248373*:A5D2D58A:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BDBB58 2025-06-17 08:23:39.248944 :A5D2D58B: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-17 08:23:39.254418 :A5D2D593: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-17 08:23:39.255396 :A5D2D59B: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-17 08:23:39.255526 :A5D2D5A4: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-17 08:24:09.348323 :A5D2DF67:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:24:14.305395 :A5D2E141:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:24:14.294 2025-06-17 08:24:14.305397 :A5D2E142:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16044 pso_num=25 pso_serial#=190 2025-06-17 08:24:14.305543 :A5D2E143:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16044 osp_idx=23 osp_ver=159932 osp_pg=0 (spawn #293941) 2025-06-17 08:24:14.305544 :A5D2E144: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-17 08:24:14.305544 :A5D2E145:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=220 time=3124397485 2025-06-17 08:24:14.305545 :A5D2E146:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:24:14.305545 :A5D2E147:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:24:14.305546 :A5D2E148:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:24:14.305546 :A5D2E149:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:24:14.305547 :A5D2E14A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:24:14.306072 :A5D2E14B: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-17 08:24:44.404676 :A5D2EC1C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:25:14.404829 :A5D2F5EB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:25:14.393 2025-06-17 08:25:14.404831 :A5D2F5EC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16544 pso_num=25 pso_serial#=191 2025-06-17 08:25:14.404988 :A5D2F5ED:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16544 osp_idx=23 osp_ver=159933 osp_pg=0 (spawn #293943) 2025-06-17 08:25:14.404989 :A5D2F5EE: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-17 08:25:14.404989 :A5D2F5EF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=221 time=3124457594 2025-06-17 08:25:14.404990 :A5D2F5F0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:25:14.404990 :A5D2F5F1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:25:14.404990 :A5D2F5F2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:25:14.404991 :A5D2F5F3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:25:14.404991 :A5D2F5F4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:25:14.405485 :A5D2F5F5: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-17 08:25:44.490151 :A5D2FFD1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:14.483571 :A5D309C2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:14.472 2025-06-17 08:26:14.483573 :A5D309C3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16204 pso_num=25 pso_serial#=192 2025-06-17 08:26:14.483718 :A5D309C4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16204 osp_idx=23 osp_ver=159934 osp_pg=0 (spawn #293945) 2025-06-17 08:26:14.483718 :A5D309C5: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-17 08:26:14.483719 :A5D309C6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=222 time=3124517672 2025-06-17 08:26:14.483719 :A5D309C7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:26:14.483719 :A5D309C8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:26:14.483720 :A5D309C9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:26:14.483720 :A5D309CA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:26:14.483720 :A5D309CB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:26:14.484219 :A5D309CC: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-17 08:26:44.538279 :A5D313A6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:46.490927 :A5D3328C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:46.476 2025-06-17 08:26:46.490928 :A5D3328D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12732 pso_num=25 pso_serial#=193 2025-06-17 08:26:46.491062 :A5D3328E:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=12732 (legacy spawn) 2025-06-17 08:26:46.497478 :A5D3329A: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-17 08:26:46.497559 :A5D332A7: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-17 08:26:46.498341 :A5D33339:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:46.507237 :A5D33542:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:46.492 2025-06-17 08:26:46.507238 :A5D33543:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10948 pso_num=25 pso_serial#=194 2025-06-17 08:26:46.507370 :A5D33544:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=10948 (legacy spawn) 2025-06-17 08:26:46.513900 :A5D3381C: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-17 08:26:46.514046 :A5D33825: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-17 08:26:46.514822 :A5D33826:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:49.687123 :A5D38350:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:49.674 2025-06-17 08:26:49.687125 :A5D38351:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16208 pso_num=25 pso_serial#=195 2025-06-17 08:26:49.687257 :A5D38352:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=16208 (legacy spawn) 2025-06-17 08:26:49.693678 :A5D38353: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-17 08:26:49.693979 :A5D3835C: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-17 08:26:49.694775 :A5D3835F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:49.703475 :A5D38362:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:49.689 2025-06-17 08:26:49.703477 :A5D38363:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17240 pso_num=25 pso_serial#=196 2025-06-17 08:26:49.703613 :A5D38364:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=17240 (legacy spawn) 2025-06-17 08:26:49.710168 :A5D38365: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-17 08:26:49.710500 :A5D3836E: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-17 08:26:49.711293 :A5D3836F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:50.436294 :A5D3849B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:50.434 2025-06-17 08:26:50.436296 :A5D3849C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3448 pso_num=25 pso_serial#=197 2025-06-17 08:26:50.436459 :A5D3849D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3448 osp_idx=23 osp_ver=159939 osp_pg=0 (spawn #293947) 2025-06-17 08:26:50.436460 :A5D3849E: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-17 08:26:50.436461 :A5D3849F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=223 time=3124553610 2025-06-17 08:26:50.436461 :A5D384A0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:26:50.436462 :A5D384A1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:26:50.436462 :A5D384A2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:26:50.436462 :A5D384A3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:26:50.436463 :A5D384A4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:26:50.437766 :A5D384A5: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-17 08:26:50.437810 :A5D384AB: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-17 08:26:50.526890 :A5D384DD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:52.655585 :A5D385C1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:52.647 2025-06-17 08:26:52.655587 :A5D385C2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17000 pso_num=25 pso_serial#=198 2025-06-17 08:26:52.655724 :A5D385C3:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=17000 (legacy spawn) 2025-06-17 08:26:52.662229 :A5D385C4: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-17 08:26:52.662401 :A5D385C9: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-17 08:26:52.663195 :A5D385CE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-06-17 08:26:52.732495 :A5D385E4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 06-17 08:26:52.720 2025-06-17 08:26:52.732497 :A5D385E5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17320 pso_num=25 pso_serial#=199 2025-06-17 08:26:52.732628 :A5D385E6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17320 osp_idx=23 osp_ver=159941 osp_pg=0 (spawn #293949) 2025-06-17 08:26:52.732629 :A5D385E7: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-17 08:26:52.732630 :A5D385E8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=224 time=3124555922 2025-06-17 08:26:52.732630 :A5D385E9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-06-17 08:26:52.732631 :A5D385EA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-06-17 08:26:52.732631 :A5D385EB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-06-17 08:26:52.732631 :A5D385EC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-17 08:26:52.732632 :A5D385ED:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-17 08:26:52.733121 :A5D385EE: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-17 08:26:52.733180 :A5D385F4: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: 17320, M002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de