Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250426220725\orcl_w000_9536_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250426220725\orcl_w000_9536_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:37585M/63366M, Ph+PgF:45261M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 9536, image: ORACLE.EXE (W000) *** 2025-04-26 22:07:25.387 *** SESSION ID:(177.33345) 2025-04-26 22:07:25.387 *** 2025-04-26 22:07:25.387 Process diagnostic dump for ORACLE.EXE (W000), OS id=9536, pid: 22, proc_ser: 145, sid: 177, sess_ser: 33345 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=4.638867 sec, exc=4.638867 sec, total=4.638867 sec wait times: max=5.000000 sec, heur=5 min 55 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.000027 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.008684 sec, exc=5.008684 sec, total=5.008684 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=69 seq_num=70 snap_id=1 wait times: snap=5.004635 sec, exc=5.004635 sec, total=5.004635 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=68 seq_num=69 snap_id=1 wait times: snap=5.014730 sec, exc=5.014730 sec, total=5.014730 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=67 seq_num=68 snap_id=1 wait times: snap=5.010142 sec, exc=5.010142 sec, total=5.010142 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=66 seq_num=67 snap_id=1 wait times: snap=5.009203 sec, exc=5.009203 sec, total=5.009203 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=65 seq_num=66 snap_id=1 wait times: snap=5.015226 sec, exc=5.015226 sec, total=5.015226 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=64 seq_num=65 snap_id=1 wait times: snap=5.003520 sec, exc=5.003520 sec, total=5.003520 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=63 seq_num=64 snap_id=1 wait times: snap=5.013282 sec, exc=5.013282 sec, total=5.013282 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 8: 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.009184 sec, exc=5.009184 sec, total=5.009184 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 9: 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.010148 sec, exc=5.010148 sec, total=5.010148 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time Sampled Session History of session 177 serial 33345 --------------------------------------------------- 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, 22:05:25 - 22:07:25] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-26 22:07:25.387 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 9536, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-04-26 20:00:45.309421 :8F25A099:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.309450 :8F25A09C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.309458 :8F25A09D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-04-26 20:00:45.309596 :8F25A0A3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.309613 :8F25A0A6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.309619 :8F25A0A7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-04-26 20:00:45.309720 :8F25A0AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.309736 :8F25A0B0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.309741 :8F25A0B1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-04-26 20:00:45.309855 :8F25A0B7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.309870 :8F25A0BA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.309876 :8F25A0BB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-04-26 20:00:45.309972 :8F25A0C1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.309986 :8F25A0C4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.309992 :8F25A0C5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-04-26 20:00:45.310087 :8F25A0CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.310103 :8F25A0CE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.310613 :8F25A0D4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-04-26 20:00:45.310734 :8F25A0D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.310753 :8F25A0D8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.314636 :8F25A0F1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.314714 :8F25A0F4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpus:psdpgi.c:2235 2025-04-26 20:00:45.314961 :8F25A0FA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.314983 :8F25A0FD:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:22:177] atxpop:psdpgi.c:2235 2025-04-26 20:00:45.317167 :8F25A103:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-26 20:00:45.317338 :8F25A10C:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 20:01:15.432766 :8F25AB1E:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 20:01:15.452855 :8F25AB3F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 20:01:15.448 2025-04-26 20:01:15.452857 :8F25AB40:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=7100 pso_num=22 pso_serial#=134 2025-04-26 20:01:15.452989 :8F25AB41:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=7100 osp_idx=0 osp_ver=127379 osp_pg=0 (spawn #121322) 2025-04-26 20:01:15.452990 :8F25AB42:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 20:01:15.452991 :8F25AB43:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=72 time=2968477250 2025-04-26 20:01:15.452991 :8F25AB44:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 20:01:15.452992 :8F25AB45:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 20:01:15.452992 :8F25AB46:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 20:01:15.452992 :8F25AB47:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 20:01:15.452993 :8F25AB48:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 20:01:15.453527 :8F25AB49:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 20:01:15.453583 :8F25AB50:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 20:11:16.324454 :8F267F04:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 20:11:16.657141 :8F267F34:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 20:11:16.653 2025-04-26 20:11:16.657143 :8F267F35:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9804 pso_num=22 pso_serial#=135 2025-04-26 20:11:16.657279 :8F267F36:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9804 osp_idx=0 osp_ver=127380 osp_pg=0 (spawn #121348) 2025-04-26 20:11:16.657279 :8F267F37:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 20:11:16.657280 :8F267F38:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=73 time=2969078453 2025-04-26 20:11:16.657280 :8F267F39:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 20:11:16.657280 :8F267F3A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 20:11:16.657281 :8F267F3B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 20:11:16.657281 :8F267F3C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 20:11:16.657281 :8F267F3D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 20:11:16.657761 :8F267F3E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 20:11:16.657809 :8F267F45:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 20:21:17.426561 :8F274740:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 20:21:17.728144 :8F27476F:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 20:21:17.723 2025-04-26 20:21:17.728146 :8F274770:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=996 pso_num=22 pso_serial#=136 2025-04-26 20:21:17.728278 :8F274771:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=996 osp_idx=0 osp_ver=127381 osp_pg=0 (spawn #121370) 2025-04-26 20:21:17.728279 :8F274772:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 20:21:17.728279 :8F274773:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=74 time=2969679531 2025-04-26 20:21:17.728281 :8F274774:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 20:21:17.728282 :8F274775:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 20:21:17.728282 :8F274776:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 20:21:17.728282 :8F274777:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 20:21:17.728283 :8F274778:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 20:21:17.728770 :8F274779:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 20:21:17.728812 :8F274781:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 20:31:18.709187 :8F2811E6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 20:31:18.917045 :8F281218:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 20:31:18.912 2025-04-26 20:31:18.917048 :8F281219:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10360 pso_num=22 pso_serial#=137 2025-04-26 20:31:18.917212 :8F28121A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10360 osp_idx=0 osp_ver=127382 osp_pg=0 (spawn #121393) 2025-04-26 20:31:18.917213 :8F28121B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 20:31:18.917213 :8F28121C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=75 time=2970280718 2025-04-26 20:31:18.917214 :8F28121D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 20:31:18.917214 :8F28121E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 20:31:18.917215 :8F28121F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 20:31:18.917215 :8F281220:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 20:31:18.917216 :8F281221:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 20:31:18.917709 :8F281222:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 20:31:18.917756 :8F28122B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 20:41:19.818928 :8F28DB52:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 20:41:20.167393 :8F28DB9D:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 20:41:20.163 2025-04-26 20:41:20.167395 :8F28DB9E:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9580 pso_num=22 pso_serial#=138 2025-04-26 20:41:20.167534 :8F28DB9F:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9580 osp_idx=0 osp_ver=127383 osp_pg=0 (spawn #121416) 2025-04-26 20:41:20.167535 :8F28DBA0:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 20:41:20.167535 :8F28DBA1:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=76 time=2970881968 2025-04-26 20:41:20.167536 :8F28DBA2:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 20:41:20.167536 :8F28DBA3:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 20:41:20.167537 :8F28DBA4:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 20:41:20.167537 :8F28DBA5:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 20:41:20.167537 :8F28DBA6:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 20:41:20.168035 :8F28DBA7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 20:41:20.168082 :8F28DBAF:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 20:51:20.966575 :8F29A596:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 20:51:21.377625 :8F29A5B8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 20:51:21.372 2025-04-26 20:51:21.377626 :8F29A5B9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9836 pso_num=22 pso_serial#=139 2025-04-26 20:51:21.377764 :8F29A5BA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9836 osp_idx=0 osp_ver=127384 osp_pg=0 (spawn #121438) 2025-04-26 20:51:21.377764 :8F29A5BB:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 20:51:21.377765 :8F29A5BC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=77 time=2971483171 2025-04-26 20:51:21.377765 :8F29A5BD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 20:51:21.377765 :8F29A5BE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 20:51:21.377766 :8F29A5BF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 20:51:21.377766 :8F29A5C0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 20:51:21.377766 :8F29A5C1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 20:51:21.378271 :8F29A5C2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 20:51:21.378313 :8F29A5CA:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 21:01:22.297610 :8F2A720F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 21:01:22.645859 :8F2A7232:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 21:01:22.641 2025-04-26 21:01:22.645861 :8F2A7233:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10896 pso_num=22 pso_serial#=140 2025-04-26 21:01:22.646001 :8F2A7234:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10896 osp_idx=0 osp_ver=127385 osp_pg=0 (spawn #121463) 2025-04-26 21:01:22.646002 :8F2A7235:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 21:01:22.646002 :8F2A7236:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=78 time=2972084437 2025-04-26 21:01:22.646003 :8F2A7237:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 21:01:22.646004 :8F2A7238:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 21:01:22.646004 :8F2A7239:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 21:01:22.646004 :8F2A723A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 21:01:22.646005 :8F2A723B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 21:01:22.646491 :8F2A723C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 21:01:22.646539 :8F2A7243:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 21:11:23.522675 :8F2B45F3:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 21:11:23.855536 :8F2B4617:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 21:11:23.850 2025-04-26 21:11:23.855538 :8F2B4618:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8260 pso_num=22 pso_serial#=141 2025-04-26 21:11:23.855680 :8F2B4619:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8260 osp_idx=0 osp_ver=127386 osp_pg=0 (spawn #121489) 2025-04-26 21:11:23.855681 :8F2B461A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 21:11:23.855681 :8F2B461B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=79 time=2972685656 2025-04-26 21:11:23.855681 :8F2B461C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 21:11:23.855682 :8F2B461D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 21:11:23.855682 :8F2B461E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 21:11:23.855683 :8F2B461F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 21:11:23.855683 :8F2B4620:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 21:11:23.856187 :8F2B4621:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 21:11:23.856236 :8F2B4628:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 21:21:24.728446 :8F2C1002:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 21:21:25.061105 :8F2C1031:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 21:21:25.056 2025-04-26 21:21:25.061107 :8F2C1032:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8276 pso_num=22 pso_serial#=142 2025-04-26 21:21:25.061240 :8F2C1033:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8276 osp_idx=0 osp_ver=127387 osp_pg=0 (spawn #121511) 2025-04-26 21:21:25.061241 :8F2C1034:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 21:21:25.061241 :8F2C1035:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=80 time=2973286859 2025-04-26 21:21:25.061242 :8F2C1036:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 21:21:25.061242 :8F2C1037:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 21:21:25.061242 :8F2C1038:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 21:21:25.061243 :8F2C1039:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 21:21:25.061243 :8F2C103A:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 21:21:25.061733 :8F2C103B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 21:21:25.061779 :8F2C1042:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 21:31:25.947940 :8F2CDB05:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 21:31:26.390429 :8F2CDB4A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 21:31:26.385 2025-04-26 21:31:26.390431 :8F2CDB4B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10356 pso_num=22 pso_serial#=143 2025-04-26 21:31:26.390575 :8F2CDB4C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10356 osp_idx=0 osp_ver=127388 osp_pg=0 (spawn #121534) 2025-04-26 21:31:26.390576 :8F2CDB4D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 21:31:26.390576 :8F2CDB4E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=81 time=2973888187 2025-04-26 21:31:26.390577 :8F2CDB4F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 21:31:26.390577 :8F2CDB50:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 21:31:26.390577 :8F2CDB51:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 21:31:26.390578 :8F2CDB52:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 21:31:26.390578 :8F2CDB53:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 21:31:26.391144 :8F2CDB54:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 21:31:26.391214 :8F2CDB5E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 21:37:43.471441 :8F2D5995:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 21:41:27.665212 :8F2DA506:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 21:51:28.435847 :8F2E6F33:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 21:51:29.002591 :8F2E6FA3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 21:51:28.998 2025-04-26 21:51:29.002593 :8F2E6FA4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10472 pso_num=22 pso_serial#=144 2025-04-26 21:51:29.002727 :8F2E6FA5:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10472 osp_idx=0 osp_ver=127389 osp_pg=0 (spawn #121578) 2025-04-26 21:51:29.002728 :8F2E6FA6:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 21:51:29.002728 :8F2E6FA7:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=82 time=2975090796 2025-04-26 21:51:29.002729 :8F2E6FA8:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 21:51:29.002729 :8F2E6FA9:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 21:51:29.002729 :8F2E6FAA:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 21:51:29.002730 :8F2E6FAB:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 21:51:29.002730 :8F2E6FAC:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 21:51:29.003214 :8F2E6FAD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 21:51:29.003257 :8F2E6FB5:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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-04-26 22:01:29.830805 :8F2F3BCD:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-04-26 22:01:30.257385 :8F2F3C1A:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 04-26 22:01:30.253 2025-04-26 22:01:30.257387 :8F2F3C1B:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9536 pso_num=22 pso_serial#=145 2025-04-26 22:01:30.257523 :8F2F3C1C:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9536 osp_idx=0 osp_ver=127390 osp_pg=0 (spawn #121603) 2025-04-26 22:01:30.257523 :8F2F3C1D:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-26 22:01:30.257524 :8F2F3C1E:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=83 time=2975692046 2025-04-26 22:01:30.257524 :8F2F3C1F:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-04-26 22:01:30.257525 :8F2F3C20:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-04-26 22:01:30.257526 :8F2F3C21:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-04-26 22:01:30.257526 :8F2F3C22:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-26 22:01:30.257526 :8F2F3C23:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-26 22:01:30.258014 :8F2F3C24:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-04-26 22:01:30.258060 :8F2F3C2A:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] 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 22 (osid: 9536, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de