Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250513220006\orcl_w000_12292_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250513220006\orcl_w000_12292_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:37409M/63366M, Ph+PgF:44705M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 12292, image: ORACLE.EXE (W000) *** 2025-05-13 22:00:06.706 *** SESSION ID:(201.13419) 2025-05-13 22:00:06.706 *** 2025-05-13 22:00:06.706 Process diagnostic dump for ORACLE.EXE (W000), OS id=12292, pid: 25, proc_ser: 121, sid: 201, sess_ser: 13419 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=63 seq_num=64 snap_id=1 wait times: snap=4.175651 sec, exc=4.175651 sec, total=4.175651 sec wait times: max=5.000000 sec, heur=5 min 14 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000043 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=62 seq_num=63 snap_id=1 wait times: snap=5.005944 sec, exc=5.005944 sec, total=5.005944 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000044 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=61 seq_num=62 snap_id=1 wait times: snap=5.004617 sec, exc=5.004617 sec, total=5.004617 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000030 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=60 seq_num=61 snap_id=1 wait times: snap=5.004620 sec, exc=5.004620 sec, total=5.004620 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=59 seq_num=60 snap_id=1 wait times: snap=5.009193 sec, exc=5.009193 sec, total=5.009193 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=58 seq_num=59 snap_id=1 wait times: snap=5.005135 sec, exc=5.005135 sec, total=5.005135 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=57 seq_num=58 snap_id=1 wait times: snap=5.003343 sec, exc=5.003343 sec, total=5.003343 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000040 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=56 seq_num=57 snap_id=1 wait times: snap=5.015097 sec, exc=5.015097 sec, total=5.015097 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=55 seq_num=56 snap_id=1 wait times: snap=5.010724 sec, exc=5.010724 sec, total=5.010724 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=54 seq_num=55 snap_id=1 wait times: snap=5.004609 sec, exc=5.004609 sec, total=5.004609 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=53 seq_num=54 snap_id=1 wait times: snap=5.014706 sec, exc=5.014706 sec, total=5.014706 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time Sampled Session History of session 201 serial 13419 --------------------------------------------------- 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 --------------------------------------------------- [121 samples, 21:58:06 - 22:00:06] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-13 22:00:06.706 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 12292, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-13 19:24:31.076932 :96A55733:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 19:24:31.378501 :96A5576E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 19:24:31.374 2025-05-13 19:24:31.378503 :96A5576F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9460 pso_num=25 pso_serial#=108 2025-05-13 19:24:31.378648 :96A55770:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9460 osp_idx=23 osp_ver=94202 osp_pg=0 (spawn #178796) 2025-05-13 19:24:31.378649 :96A55771:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 19:24:31.378649 :96A55772:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=218 time=140081250 2025-05-13 19:24:31.378650 :96A55773:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 19:24:31.378650 :96A55774:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 19:24:31.378651 :96A55775:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 19:24:31.378651 :96A55776:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 19:24:31.378651 :96A55777:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 19:24:31.379140 :96A55778:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 19:24:31.379185 :96A55780:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 19:32:12.791925 :96A5EC88:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-13 19:34:32.645596 :96A619BA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-13 19:44:33.603795 :96A6DAFE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 19:44:33.920613 :96A6DB6A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 19:44:33.915 2025-05-13 19:44:33.920615 :96A6DB6B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2804 pso_num=25 pso_serial#=109 2025-05-13 19:44:33.920751 :96A6DB6C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2804 osp_idx=23 osp_ver=94203 osp_pg=0 (spawn #178840) 2025-05-13 19:44:33.920752 :96A6DB6D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 19:44:33.920752 :96A6DB6E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=219 time=141283797 2025-05-13 19:44:33.920753 :96A6DB6F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 19:44:33.920753 :96A6DB70:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 19:44:33.920754 :96A6DB71:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 19:44:33.920754 :96A6DB72:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 19:44:33.920755 :96A6DB73:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 19:44:33.921248 :96A6DB74:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 19:44:33.921292 :96A6DB7C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 19:54:34.748222 :96A79C9B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 19:54:35.315473 :96A79CF8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 19:54:35.311 2025-05-13 19:54:35.315475 :96A79CF9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12644 pso_num=25 pso_serial#=110 2025-05-13 19:54:35.315606 :96A79CFA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12644 osp_idx=23 osp_ver=94204 osp_pg=0 (spawn #178863) 2025-05-13 19:54:35.315606 :96A79CFB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 19:54:35.315607 :96A79CFC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=220 time=141885188 2025-05-13 19:54:35.315607 :96A79CFD:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 19:54:35.315607 :96A79CFE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 19:54:35.315608 :96A79CFF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 19:54:35.315608 :96A79D00:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 19:54:35.315608 :96A79D01:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 19:54:35.316093 :96A79D02:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 19:54:35.316144 :96A79D08:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 20:04:36.264104 :96A86164:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 20:04:36.581024 :96A861CC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 20:04:36.576 2025-05-13 20:04:36.581026 :96A861CD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12488 pso_num=25 pso_serial#=111 2025-05-13 20:04:36.581164 :96A861CE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12488 osp_idx=23 osp_ver=94205 osp_pg=0 (spawn #178888) 2025-05-13 20:04:36.581165 :96A861CF:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 20:04:36.581165 :96A861D0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=221 time=142486454 2025-05-13 20:04:36.581165 :96A861D1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 20:04:36.581166 :96A861D2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 20:04:36.581166 :96A861D3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 20:04:36.581167 :96A861D4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 20:04:36.581167 :96A861D5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 20:04:36.581712 :96A861D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 20:04:36.581760 :96A861DE:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 20:14:37.593974 :96A92A40:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 20:14:37.880760 :96A92A98:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 20:14:37.875 2025-05-13 20:14:37.880762 :96A92A99:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12016 pso_num=25 pso_serial#=112 2025-05-13 20:14:37.880901 :96A92A9A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12016 osp_idx=23 osp_ver=94206 osp_pg=0 (spawn #178911) 2025-05-13 20:14:37.880902 :96A92A9B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 20:14:37.880902 :96A92A9C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=222 time=143087750 2025-05-13 20:14:37.880903 :96A92A9D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 20:14:37.880903 :96A92A9E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 20:14:37.880903 :96A92A9F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 20:14:37.880904 :96A92AA0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 20:14:37.880904 :96A92AA1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 20:14:37.881395 :96A92AA2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 20:14:37.881437 :96A92AAA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 20:24:38.868477 :96A9EE90:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 20:24:39.216775 :96A9EEEA:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 20:24:39.212 2025-05-13 20:24:39.216778 :96A9EEEB:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12304 pso_num=25 pso_serial#=113 2025-05-13 20:24:39.216923 :96A9EEEC:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12304 osp_idx=23 osp_ver=94207 osp_pg=0 (spawn #178934) 2025-05-13 20:24:39.216924 :96A9EEED:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 20:24:39.216924 :96A9EEEE:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=223 time=143689094 2025-05-13 20:24:39.216924 :96A9EEEF:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 20:24:39.216925 :96A9EEF0:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 20:24:39.216925 :96A9EEF1:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 20:24:39.216926 :96A9EEF2:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 20:24:39.216926 :96A9EEF3:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 20:24:39.217434 :96A9EEF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 20:24:39.217477 :96A9EEFA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 20:34:40.161839 :96AAB0F4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 20:34:40.510332 :96AAB135:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 20:34:40.505 2025-05-13 20:34:40.510334 :96AAB136:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11212 pso_num=25 pso_serial#=114 2025-05-13 20:34:40.510470 :96AAB137:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11212 osp_idx=23 osp_ver=94208 osp_pg=0 (spawn #178956) 2025-05-13 20:34:40.510470 :96AAB138:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 20:34:40.510473 :96AAB139:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=224 time=144290375 2025-05-13 20:34:40.510473 :96AAB13A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 20:34:40.510473 :96AAB13B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 20:34:40.510474 :96AAB13C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 20:34:40.510474 :96AAB13D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 20:34:40.510474 :96AAB13E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 20:34:40.510985 :96AAB13F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 20:34:40.511041 :96AAB146:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 20:44:41.336470 :96AB737F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 20:44:41.934996 :96AB73BC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 20:44:41.930 2025-05-13 20:44:41.934998 :96AB73BD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13104 pso_num=25 pso_serial#=115 2025-05-13 20:44:41.935133 :96AB73BE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13104 osp_idx=23 osp_ver=94209 osp_pg=0 (spawn #178979) 2025-05-13 20:44:41.935134 :96AB73BF:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 20:44:41.935134 :96AB73C0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=225 time=144891797 2025-05-13 20:44:41.935135 :96AB73C1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 20:44:41.935136 :96AB73C2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 20:44:41.935136 :96AB73C3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 20:44:41.935136 :96AB73C4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 20:44:41.935137 :96AB73C5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 20:44:41.935633 :96AB73C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 20:44:41.935681 :96AB73CF:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 20:54:42.783491 :96AC3541:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 20:54:43.225910 :96AC3585:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 20:54:43.220 2025-05-13 20:54:43.225913 :96AC3586:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4804 pso_num=25 pso_serial#=116 2025-05-13 20:54:43.226045 :96AC3587:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4804 osp_idx=23 osp_ver=94210 osp_pg=0 (spawn #179002) 2025-05-13 20:54:43.226046 :96AC3588:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 20:54:43.226046 :96AC3589:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=226 time=145493094 2025-05-13 20:54:43.226047 :96AC358A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 20:54:43.226047 :96AC358B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 20:54:43.226047 :96AC358C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 20:54:43.226048 :96AC358D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 20:54:43.226048 :96AC358E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 20:54:43.226534 :96AC358F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 20:54:43.226579 :96AC3596:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 21:04:44.220524 :96ACFA6C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 21:04:44.756492 :96ACFAA1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 21:04:44.751 2025-05-13 21:04:44.756494 :96ACFAA2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8848 pso_num=25 pso_serial#=117 2025-05-13 21:04:44.756633 :96ACFAA3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8848 osp_idx=23 osp_ver=94211 osp_pg=0 (spawn #179027) 2025-05-13 21:04:44.756634 :96ACFAA4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 21:04:44.756634 :96ACFAA5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=227 time=146094625 2025-05-13 21:04:44.756635 :96ACFAA6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 21:04:44.756635 :96ACFAA7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 21:04:44.756635 :96ACFAA8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 21:04:44.756636 :96ACFAA9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 21:04:44.756636 :96ACFAAA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 21:04:44.757131 :96ACFAAB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 21:04:44.757174 :96ACFAB2:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 21:14:45.661068 :96ADC42B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 21:14:46.160287 :96ADC4A4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 21:14:46.156 2025-05-13 21:14:46.160290 :96ADC4A5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13008 pso_num=25 pso_serial#=118 2025-05-13 21:14:46.160434 :96ADC4A6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13008 osp_idx=23 osp_ver=94212 osp_pg=0 (spawn #179050) 2025-05-13 21:14:46.160435 :96ADC4A7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 21:14:46.160435 :96ADC4A8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=228 time=146696032 2025-05-13 21:14:46.160436 :96ADC4A9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 21:14:46.160436 :96ADC4AA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 21:14:46.160437 :96ADC4AB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 21:14:46.160437 :96ADC4AC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 21:14:46.160437 :96ADC4AD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 21:14:46.160952 :96ADC4AE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 21:14:46.160996 :96ADC4B6:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 21:24:47.026397 :96AE896F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 21:24:47.671757 :96AE89CC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 21:24:47.666 2025-05-13 21:24:47.671759 :96AE89CD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8212 pso_num=25 pso_serial#=119 2025-05-13 21:24:47.671891 :96AE89CE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8212 osp_idx=23 osp_ver=94213 osp_pg=0 (spawn #179073) 2025-05-13 21:24:47.671892 :96AE89CF:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 21:24:47.671892 :96AE89D0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=229 time=147297547 2025-05-13 21:24:47.671893 :96AE89D1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 21:24:47.671893 :96AE89D2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 21:24:47.671893 :96AE89D3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 21:24:47.671894 :96AE89D4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 21:24:47.671894 :96AE89D5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 21:24:47.672387 :96AE89D6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 21:24:47.672434 :96AE89DE:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 21:34:48.605614 :96AF4B8E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 21:34:49.151663 :96AF4BF9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 21:34:49.147 2025-05-13 21:34:49.151666 :96AF4BFA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10096 pso_num=25 pso_serial#=120 2025-05-13 21:34:49.151797 :96AF4BFB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10096 osp_idx=23 osp_ver=94214 osp_pg=0 (spawn #179095) 2025-05-13 21:34:49.151798 :96AF4BFC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 21:34:49.151798 :96AF4BFD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=230 time=147899016 2025-05-13 21:34:49.151798 :96AF4BFE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 21:34:49.151799 :96AF4BFF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 21:34:49.151799 :96AF4C00:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 21:34:49.151799 :96AF4C01:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 21:34:49.151799 :96AF4C02:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 21:34:49.152332 :96AF4C03:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 21:34:49.152375 :96AF4C0C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-13 21:35:15.392303 :96AF543D:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-13 21:44:50.637241 :96B00E60:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-13 21:54:51.575074 :96B0D00C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-13 21:54:52.032837 :96B0D066:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-13 21:54:52.033 2025-05-13 21:54:52.032838 :96B0D067:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12292 pso_num=25 pso_serial#=121 2025-05-13 21:54:52.033037 :96B0D068:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12292 osp_idx=23 osp_ver=94215 osp_pg=0 (spawn #179140) 2025-05-13 21:54:52.033039 :96B0D069:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-13 21:54:52.033039 :96B0D06A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=231 time=149101907 2025-05-13 21:54:52.033040 :96B0D06B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-13 21:54:52.033040 :96B0D06C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-13 21:54:52.033041 :96B0D06D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-13 21:54:52.033041 :96B0D06E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-13 21:54:52.033042 :96B0D06F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-13 21:54:52.033547 :96B0D070:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-13 21:54:52.033593 :96B0D078:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 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: 12292, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de