Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250822220008\orcl_w000_20312_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250822220008\orcl_w000_20312_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:35305M/63366M, Ph+PgF:40477M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 20312, image: ORACLE.EXE (W000) *** 2025-08-22 22:00:08.716 *** SESSION ID:(201.31851) 2025-08-22 22:00:08.716 *** 2025-08-22 22:00:08.716 Process diagnostic dump for ORACLE.EXE (W000), OS id=20312, pid: 25, proc_ser: 191, sid: 201, sess_ser: 31851 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=91 seq_num=92 snap_id=1 wait times: snap=4.810646 sec, exc=4.810646 sec, total=4.810646 sec wait times: max=5.000000 sec, heur=7 min 35 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.000025 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=90 seq_num=91 snap_id=1 wait times: snap=5.014760 sec, exc=5.014760 sec, total=5.014760 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=89 seq_num=90 snap_id=1 wait times: snap=5.014746 sec, exc=5.014746 sec, total=5.014746 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=88 seq_num=89 snap_id=1 wait times: snap=5.004624 sec, exc=5.004624 sec, total=5.004624 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=87 seq_num=88 snap_id=1 wait times: snap=5.004648 sec, exc=5.004648 sec, total=5.004648 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=86 seq_num=87 snap_id=1 wait times: snap=5.008613 sec, exc=5.008613 sec, total=5.008613 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=85 seq_num=86 snap_id=1 wait times: snap=5.002055 sec, exc=5.002055 sec, total=5.002055 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=84 seq_num=85 snap_id=1 wait times: snap=5.013849 sec, exc=5.013849 sec, total=5.013849 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=83 seq_num=84 snap_id=1 wait times: snap=5.004670 sec, exc=5.004670 sec, total=5.004670 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=82 seq_num=83 snap_id=1 wait times: snap=5.004608 sec, exc=5.004608 sec, total=5.004608 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=81 seq_num=82 snap_id=1 wait times: snap=5.004631 sec, exc=5.004631 sec, total=5.004631 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time Sampled Session History of session 201 serial 31851 --------------------------------------------------- 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:08 - 22:00:08] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-22 22:00:08.716 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 20312, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-22 20:35:22.892435 :C3463EE6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=196 time=280624893 2025-08-22 20:35:22.892436 :C3463EE7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:35:22.892436 :C3463EE8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:35:22.892437 :C3463EE9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:35:22.892437 :C3463EEA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:35:22.892438 :C3463EEB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:35:22.892898 :C3463EEC: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-08-22 20:35:52.971919 :C34648E1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:36:22.975574 :C3465276:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:36:22.964 2025-08-22 20:36:22.975576 :C3465277:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22256 pso_num=25 pso_serial#=177 2025-08-22 20:36:22.975694 :C3465278:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22256 osp_idx=23 osp_ver=252484 osp_pg=0 (spawn #515615) 2025-08-22 20:36:22.975695 :C3465279:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:36:22.975695 :C346527A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=197 time=280684987 2025-08-22 20:36:22.975696 :C346527B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:36:22.975696 :C346527C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:36:22.975696 :C346527D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:36:22.975697 :C346527E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:36:22.975697 :C346527F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:36:22.976173 :C3465280: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-08-22 20:36:37.989123 :C346573A: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-08-22 20:37:08.093644 :C346611F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:37:23.058319 :C34665C6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:37:23.047 2025-08-22 20:37:23.058321 :C34665C7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21692 pso_num=25 pso_serial#=178 2025-08-22 20:37:23.058439 :C34665C8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21692 osp_idx=23 osp_ver=252485 osp_pg=0 (spawn #515617) 2025-08-22 20:37:23.058440 :C34665C9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:37:23.058440 :C34665CA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=198 time=280745065 2025-08-22 20:37:23.058441 :C34665CB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:37:23.058441 :C34665CC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:37:23.058441 :C34665CD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:37:23.058441 :C34665CE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:37:23.058442 :C34665CF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:37:23.058914 :C34665D0: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-08-22 20:37:53.120162 :C3466F8C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:38:23.114541 :C3467931:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:38:23.103 2025-08-22 20:38:23.114543 :C3467932:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20708 pso_num=25 pso_serial#=179 2025-08-22 20:38:23.114688 :C3467933:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20708 osp_idx=23 osp_ver=252486 osp_pg=0 (spawn #515619) 2025-08-22 20:38:23.114689 :C3467934:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:38:23.114690 :C3467935:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=199 time=280805112 2025-08-22 20:38:23.114690 :C3467936:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:38:23.114691 :C3467937:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:38:23.114691 :C3467938:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:38:23.114691 :C3467939:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:38:23.114692 :C346793A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:38:23.115186 :C346793B: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-08-22 20:38:53.219379 :C3468391:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:39:23.199216 :C3468D0C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:39:23.188 2025-08-22 20:39:23.199218 :C3468D0D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19584 pso_num=25 pso_serial#=180 2025-08-22 20:39:23.199363 :C3468D0E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19584 osp_idx=23 osp_ver=252487 osp_pg=0 (spawn #515622) 2025-08-22 20:39:23.199364 :C3468D0F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:39:23.199364 :C3468D10:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=200 time=280865205 2025-08-22 20:39:23.199364 :C3468D11:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:39:23.199365 :C3468D12:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:39:23.199365 :C3468D13:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:39:23.199365 :C3468D14:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:39:23.199366 :C3468D15:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:39:23.199844 :C3468D16: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-08-22 20:39:53.278276 :C34696CA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:40:23.301080 :C346A045:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:40:23.289 2025-08-22 20:40:23.301083 :C346A046:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22320 pso_num=25 pso_serial#=181 2025-08-22 20:40:23.301209 :C346A047:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22320 osp_idx=23 osp_ver=252488 osp_pg=0 (spawn #515624) 2025-08-22 20:40:23.301210 :C346A048:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:40:23.301210 :C346A049:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=201 time=280925299 2025-08-22 20:40:23.301211 :C346A04A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:40:23.301211 :C346A04B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:40:23.301211 :C346A04C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:40:23.301212 :C346A04D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:40:23.301212 :C346A04E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:40:23.301694 :C346A04F: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-08-22 20:40:53.380586 :C346AB35:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:41:23.409497 :C346B4ED:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:41:23.398 2025-08-22 20:41:23.409499 :C346B4EE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22216 pso_num=25 pso_serial#=182 2025-08-22 20:41:23.409617 :C346B4EF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22216 osp_idx=23 osp_ver=252489 osp_pg=0 (spawn #515627) 2025-08-22 20:41:23.409618 :C346B4F0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:41:23.409618 :C346B4F1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=202 time=280985408 2025-08-22 20:41:23.409619 :C346B4F2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:41:23.409620 :C346B4F3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:41:23.409620 :C346B4F4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:41:23.409621 :C346B4F5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:41:23.409621 :C346B4F6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:41:23.410133 :C346B4F7: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-08-22 20:41:53.496613 :C346BEA4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:42:23.672131 :C346C8D3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:42:23.667 2025-08-22 20:42:23.672134 :C346C8D4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22064 pso_num=25 pso_serial#=183 2025-08-22 20:42:23.672288 :C346C8D5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22064 osp_idx=23 osp_ver=252490 osp_pg=0 (spawn #515630) 2025-08-22 20:42:23.672289 :C346C8D6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:42:23.672290 :C346C8D7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=203 time=281045690 2025-08-22 20:42:23.672291 :C346C8D8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:42:23.672291 :C346C8D9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:42:23.672292 :C346C8DA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:42:23.672292 :C346C8DB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:42:23.672293 :C346C8DC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:42:23.672819 :C346C8DD: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-08-22 20:42:23.672864 :C346C8E4: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-08-22 20:52:24.666749 :C3478CF3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 20:52:25.062030 :C3478D3A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 20:52:25.057 2025-08-22 20:52:25.062033 :C3478D3B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=22160 pso_num=25 pso_serial#=184 2025-08-22 20:52:25.062179 :C3478D3C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=22160 osp_idx=23 osp_ver=252491 osp_pg=0 (spawn #515653) 2025-08-22 20:52:25.062179 :C3478D3D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 20:52:25.062180 :C3478D3E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=204 time=281647065 2025-08-22 20:52:25.062181 :C3478D3F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 20:52:25.062181 :C3478D40:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 20:52:25.062181 :C3478D41:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 20:52:25.062182 :C3478D42:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 20:52:25.062182 :C3478D43:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 20:52:25.062679 :C3478D44: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-08-22 20:52:25.062723 :C3478D4C: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-08-22 21:02:25.853831 :C348536D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 21:02:26.405992 :C34853B3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 21:02:26.401 2025-08-22 21:02:26.405994 :C34853B4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21052 pso_num=25 pso_serial#=185 2025-08-22 21:02:26.406150 :C34853B5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21052 osp_idx=23 osp_ver=252492 osp_pg=0 (spawn #515677) 2025-08-22 21:02:26.406151 :C34853B6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 21:02:26.406151 :C34853B7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=205 time=282248408 2025-08-22 21:02:26.406152 :C34853B8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 21:02:26.406152 :C34853B9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 21:02:26.406153 :C34853BA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 21:02:26.406153 :C34853BB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 21:02:26.406154 :C34853BC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 21:02:26.406733 :C34853BD: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-08-22 21:02:26.406808 :C34853C7: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-08-22 21:12:27.230565 :C34920A3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 21:12:27.797871 :C34920DD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 21:12:27.793 2025-08-22 21:12:27.797873 :C34920DE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18956 pso_num=25 pso_serial#=186 2025-08-22 21:12:27.798019 :C34920DF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18956 osp_idx=23 osp_ver=252493 osp_pg=0 (spawn #515701) 2025-08-22 21:12:27.798019 :C34920E0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 21:12:27.798020 :C34920E1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=206 time=282849815 2025-08-22 21:12:27.798020 :C34920E2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 21:12:27.798020 :C34920E3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 21:12:27.798021 :C34920E4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 21:12:27.798021 :C34920E5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 21:12:27.798022 :C34920E6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 21:12:27.798529 :C34920E7: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-08-22 21:12:27.798575 :C34920F0: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-08-22 21:22:28.684446 :C349E507:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 21:22:29.246243 :C349E54D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 21:22:29.242 2025-08-22 21:22:29.246245 :C349E54E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19612 pso_num=25 pso_serial#=187 2025-08-22 21:22:29.246379 :C349E54F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19612 osp_idx=23 osp_ver=252494 osp_pg=0 (spawn #515724) 2025-08-22 21:22:29.246381 :C349E550:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 21:22:29.246381 :C349E551:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=207 time=283451252 2025-08-22 21:22:29.246381 :C349E552:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 21:22:29.246382 :C349E553:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 21:22:29.246382 :C349E554:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 21:22:29.246382 :C349E555:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 21:22:29.246383 :C349E556:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 21:22:29.246864 :C349E557: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-08-22 21:22:29.246908 :C349E55F: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-08-22 21:32:30.219688 :C34AAA11:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 21:32:30.614988 :C34AAA4B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 21:32:30.610 2025-08-22 21:32:30.614990 :C34AAA4C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19852 pso_num=25 pso_serial#=188 2025-08-22 21:32:30.615131 :C34AAA4D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19852 osp_idx=23 osp_ver=252495 osp_pg=0 (spawn #515746) 2025-08-22 21:32:30.615131 :C34AAA4E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 21:32:30.615132 :C34AAA4F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=208 time=284052627 2025-08-22 21:32:30.615132 :C34AAA50:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 21:32:30.615132 :C34AAA51:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 21:32:30.615133 :C34AAA52:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 21:32:30.615133 :C34AAA53:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 21:32:30.615133 :C34AAA54:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 21:32:30.615640 :C34AAA55: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-08-22 21:32:30.615688 :C34AAA5F: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-08-22 21:42:31.390930 :C34B6E50:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 21:42:31.911386 :C34B6EBB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 21:42:31.906 2025-08-22 21:42:31.911388 :C34B6EBC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19660 pso_num=25 pso_serial#=189 2025-08-22 21:42:31.911529 :C34B6EBD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19660 osp_idx=23 osp_ver=252496 osp_pg=0 (spawn #515769) 2025-08-22 21:42:31.911530 :C34B6EBE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 21:42:31.911530 :C34B6EBF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=209 time=284653924 2025-08-22 21:42:31.911531 :C34B6EC0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 21:42:31.911531 :C34B6EC1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 21:42:31.911531 :C34B6EC2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 21:42:31.911532 :C34B6EC3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 21:42:31.911532 :C34B6EC4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 21:42:31.912038 :C34B6EC5: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-08-22 21:42:31.912082 :C34B6ECC: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-08-22 21:52:32.808084 :C34C3363:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 21:52:33.128005 :C34C338E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 21:52:33.115 2025-08-22 21:52:33.128008 :C34C338F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19940 pso_num=25 pso_serial#=190 2025-08-22 21:52:33.128155 :C34C3390:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=19940 (legacy spawn) 2025-08-22 21:52:33.134702 :C34C3391: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-08-22 21:52:33.134874 :C34C3396: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-08-22 21:52:33.135750 :C34C339B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-22 21:52:33.229215 :C34C33D7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-22 21:52:33.224 2025-08-22 21:52:33.229217 :C34C33D8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20312 pso_num=25 pso_serial#=191 2025-08-22 21:52:33.229363 :C34C33D9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20312 osp_idx=23 osp_ver=252498 osp_pg=0 (spawn #515792) 2025-08-22 21:52:33.229364 :C34C33DA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-22 21:52:33.229364 :C34C33DB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=210 time=285255237 2025-08-22 21:52:33.229365 :C34C33DC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-22 21:52:33.229365 :C34C33DD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-22 21:52:33.229366 :C34C33DE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-22 21:52:33.229366 :C34C33DF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-22 21:52:33.229366 :C34C33E0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-22 21:52:33.229887 :C34C33E1: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-08-22 21:52:33.229933 :C34C33E9: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: 20312, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de