Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250816100714\orcl_w000_17340_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250816100714\orcl_w000_17340_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:35438M/63366M, Ph+PgF:40747M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 17340, image: ORACLE.EXE (W000) *** 2025-08-16 10:07:14.415 *** SESSION ID:(177.54069) 2025-08-16 10:07:14.415 *** 2025-08-16 10:07:14.415 Process diagnostic dump for ORACLE.EXE (W000), OS id=17340, pid: 22, proc_ser: 27, sid: 177, sess_ser: 54069 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=64 seq_num=65 snap_id=1 wait times: snap=0.446021 sec, exc=0.446021 sec, total=0.446021 sec wait times: max=5.000000 sec, heur=1 min 30 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=63 seq_num=64 snap_id=1 wait times: snap=5.014740 sec, exc=5.014740 sec, total=5.014740 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 1: 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.010132 sec, exc=5.010132 sec, total=5.010132 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 2: 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.008321 sec, exc=5.008321 sec, total=5.008321 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 3: 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.010414 sec, exc=5.010414 sec, total=5.010414 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 4: 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.006118 sec, exc=5.006118 sec, total=5.006118 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 5: 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.004615 sec, exc=5.004615 sec, total=5.004615 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 6: 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.014718 sec, exc=5.014718 sec, total=5.014718 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=56 seq_num=57 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.000025 sec of elapsed time 8: 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.014743 sec, exc=5.014743 sec, total=5.014743 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=54 seq_num=55 snap_id=1 wait times: snap=5.015315 sec, exc=5.015315 sec, total=5.015315 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time Sampled Session History of session 177 serial 54069 --------------------------------------------------- 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, 10:05:14 - 10:07:14] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-16 10:07:14.415 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 17340, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-16 07:51:50.714346 :C06771A7:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=19784 (legacy spawn) 2025-08-16 07:51:50.720861 :C06771A8: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-08-16 07:51:50.721020 :C06771B1: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-08-16 07:51:50.721809 :C06771B2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 07:51:51.155094 :C06771E7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 07:51:51.150 2025-08-16 07:51:51.155096 :C06771E8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22492 pso_num=22 pso_serial#=13 2025-08-16 07:51:51.155228 :C06771E9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22492 osp_idx=0 osp_ver=519520 osp_pg=0 (spawn #493849) 2025-08-16 07:51:51.155228 :C06771EA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 07:51:51.155229 :C06771EB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=29 time=4011380454 2025-08-16 07:51:51.155229 :C06771EC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 07:51:51.155229 :C06771ED:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 07:51:51.155229 :C06771EE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 07:51:51.155230 :C06771EF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 07:51:51.155230 :C06771F0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 07:51:51.155712 :C06771F1: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-08-16 07:51:51.155755 :C06771F9: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-08-16 08:01:51.945720 :C0683E20:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 08:01:52.466087 :C0683E8E:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 08:01:52.461 2025-08-16 08:01:52.466089 :C0683E8F:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21688 pso_num=22 pso_serial#=14 2025-08-16 08:01:52.466223 :C0683E90:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21688 osp_idx=0 osp_ver=519521 osp_pg=0 (spawn #493874) 2025-08-16 08:01:52.466224 :C0683E91:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 08:01:52.466224 :C0683E92:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=30 time=4011981767 2025-08-16 08:01:52.466225 :C0683E93:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 08:01:52.466225 :C0683E94:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 08:01:52.466226 :C0683E95:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 08:01:52.466226 :C0683E96:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 08:01:52.466226 :C0683E97:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 08:01:52.466748 :C0683E98: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-08-16 08:01:52.466793 :C0683E9F: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-08-16 08:05:43.071026 :C0689070: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-08-16 08:11:53.884876 :C0690DB5: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-08-16 08:21:54.800520 :C069D541:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 08:21:55.148982 :C069D5A2:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 08:21:55.144 2025-08-16 08:21:55.148984 :C069D5A3:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10620 pso_num=22 pso_serial#=15 2025-08-16 08:21:55.149121 :C069D5A4:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=10620 osp_idx=0 osp_ver=519522 osp_pg=0 (spawn #493920) 2025-08-16 08:21:55.149122 :C069D5A5:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 08:21:55.149123 :C069D5A6:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=31 time=4013184454 2025-08-16 08:21:55.149124 :C069D5A7:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 08:21:55.149124 :C069D5A8:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 08:21:55.149124 :C069D5A9:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 08:21:55.149125 :C069D5AA:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 08:21:55.149125 :C069D5AB:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 08:21:55.149631 :C069D5AC: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-08-16 08:21:55.149677 :C069D5B4: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-08-16 08:31:56.029851 :C06A9E30:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 08:31:56.550481 :C06A9EAA:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 08:31:56.545 2025-08-16 08:31:56.550483 :C06A9EAB:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20388 pso_num=22 pso_serial#=16 2025-08-16 08:31:56.550629 :C06A9EAC:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20388 osp_idx=0 osp_ver=519523 osp_pg=0 (spawn #493943) 2025-08-16 08:31:56.550629 :C06A9EAD:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 08:31:56.550629 :C06A9EAE:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=32 time=4013785861 2025-08-16 08:31:56.550630 :C06A9EAF:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 08:31:56.550630 :C06A9EB0:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 08:31:56.550630 :C06A9EB1:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 08:31:56.550631 :C06A9EB2:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 08:31:56.550631 :C06A9EB3:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 08:31:56.551148 :C06A9EB4: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-08-16 08:31:56.551202 :C06A9EBA: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-08-16 08:41:57.523869 :C06B67F8:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 08:41:57.966109 :C06B6833:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 08:41:57.961 2025-08-16 08:41:57.966111 :C06B6834:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21864 pso_num=22 pso_serial#=17 2025-08-16 08:41:57.966256 :C06B6835:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21864 osp_idx=0 osp_ver=519524 osp_pg=0 (spawn #493966) 2025-08-16 08:41:57.966257 :C06B6836:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 08:41:57.966257 :C06B6837:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=33 time=4014387267 2025-08-16 08:41:57.966258 :C06B6838:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 08:41:57.966258 :C06B6839:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 08:41:57.966258 :C06B683A:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 08:41:57.966259 :C06B683B:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 08:41:57.966259 :C06B683C:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 08:41:57.966750 :C06B683D: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-08-16 08:41:57.966797 :C06B6845: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-08-16 08:51:58.843108 :C06C3091:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 08:51:59.222772 :C06C30D7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 08:51:59.217 2025-08-16 08:51:59.222774 :C06C30D8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22100 pso_num=22 pso_serial#=18 2025-08-16 08:51:59.222910 :C06C30D9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22100 osp_idx=0 osp_ver=519525 osp_pg=0 (spawn #493988) 2025-08-16 08:51:59.222911 :C06C30DA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 08:51:59.222911 :C06C30DB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=34 time=4014988533 2025-08-16 08:51:59.222912 :C06C30DC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 08:51:59.222912 :C06C30DD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 08:51:59.222912 :C06C30DE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 08:51:59.222913 :C06C30DF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 08:51:59.222913 :C06C30E0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 08:51:59.223422 :C06C30E1: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-08-16 08:51:59.223469 :C06C30E8: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-08-16 09:02:00.055591 :C06CFBAC:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:02:00.484723 :C06CFBE1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:02:00.479 2025-08-16 09:02:00.484726 :C06CFBE2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21540 pso_num=22 pso_serial#=19 2025-08-16 09:02:00.484855 :C06CFBE3:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21540 osp_idx=0 osp_ver=519526 osp_pg=0 (spawn #494013) 2025-08-16 09:02:00.484856 :C06CFBE4:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 09:02:00.484856 :C06CFBE5:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=35 time=4015589783 2025-08-16 09:02:00.484857 :C06CFBE6:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 09:02:00.484857 :C06CFBE7:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 09:02:00.484857 :C06CFBE8:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 09:02:00.484857 :C06CFBE9:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 09:02:00.484858 :C06CFBEA:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 09:02:00.485331 :C06CFBEB: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-08-16 09:02:00.485374 :C06CFBF5: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-08-16 09:12:01.330341 :C06DCDF2:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:12:01.803925 :C06DCE37:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:12:01.799 2025-08-16 09:12:01.803927 :C06DCE38:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=20800 pso_num=22 pso_serial#=20 2025-08-16 09:12:01.804067 :C06DCE39:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=20800 osp_idx=0 osp_ver=519527 osp_pg=0 (spawn #494038) 2025-08-16 09:12:01.804067 :C06DCE3A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 09:12:01.804068 :C06DCE3B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=36 time=4016191111 2025-08-16 09:12:01.804068 :C06DCE3C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 09:12:01.804069 :C06DCE3D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 09:12:01.804069 :C06DCE3E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 09:12:01.804069 :C06DCE3F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 09:12:01.804070 :C06DCE40:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 09:12:01.804561 :C06DCE41: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-08-16 09:12:01.804610 :C06DCE49: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-08-16 09:22:02.687799 :C06E9484:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:22:02.795703 :C06E9487:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:22:02.781 2025-08-16 09:22:02.795705 :C06E9488:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21776 pso_num=22 pso_serial#=21 2025-08-16 09:22:02.795843 :C06E9489:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=21776 (legacy spawn) 2025-08-16 09:22:02.802356 :C06E948A: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-08-16 09:22:02.802528 :C06E948F: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-08-16 09:22:02.803336 :C06E9494:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:22:02.812002 :C06E9497:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:22:02.796 2025-08-16 09:22:02.812005 :C06E9498:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=18016 pso_num=22 pso_serial#=22 2025-08-16 09:22:02.812150 :C06E9499:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=18016 (legacy spawn) 2025-08-16 09:22:02.818627 :C06E949A: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-08-16 09:22:02.818800 :C06E94A3: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-08-16 09:22:02.819610 :C06E94A4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:22:03.020667 :C06E94DB:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:22:03.015 2025-08-16 09:22:03.020669 :C06E94DC:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=21644 pso_num=22 pso_serial#=23 2025-08-16 09:22:03.020811 :C06E94DD:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=21644 osp_idx=0 osp_ver=519530 osp_pg=0 (spawn #494060) 2025-08-16 09:22:03.020812 :C06E94DE:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 09:22:03.020812 :C06E94DF:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=37 time=4016792329 2025-08-16 09:22:03.020812 :C06E94E0:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 09:22:03.020813 :C06E94E1:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 09:22:03.020813 :C06E94E2:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 09:22:03.020813 :C06E94E3:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 09:22:03.020815 :C06E94E4:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 09:22:03.021309 :C06E94E5: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-08-16 09:22:03.021353 :C06E94EC: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-08-16 09:32:03.925095 :C06F5A94:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:32:04.367387 :C06F5ACC:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:32:04.362 2025-08-16 09:32:04.367389 :C06F5ACD:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22140 pso_num=22 pso_serial#=24 2025-08-16 09:32:04.367527 :C06F5ACE:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22140 osp_idx=0 osp_ver=519531 osp_pg=0 (spawn #494083) 2025-08-16 09:32:04.367527 :C06F5ACF:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 09:32:04.367528 :C06F5AD0:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=38 time=4017393673 2025-08-16 09:32:04.367528 :C06F5AD1:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 09:32:04.367529 :C06F5AD2:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 09:32:04.367529 :C06F5AD3:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 09:32:04.367529 :C06F5AD4:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 09:32:04.367529 :C06F5AD5:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 09:32:04.368022 :C06F5AD6: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-08-16 09:32:04.368069 :C06F5ADD: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-08-16 09:42:05.270622 :C0701FB5:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:42:05.587797 :C0701FEF:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:42:05.583 2025-08-16 09:42:05.587800 :C0701FF0:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22008 pso_num=22 pso_serial#=25 2025-08-16 09:42:05.587935 :C0701FF1:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22008 osp_idx=0 osp_ver=519532 osp_pg=0 (spawn #494106) 2025-08-16 09:42:05.587935 :C0701FF2:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 09:42:05.587936 :C0701FF3:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=39 time=4017994892 2025-08-16 09:42:05.587936 :C0701FF4:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 09:42:05.587936 :C0701FF5:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 09:42:05.587936 :C0701FF6:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 09:42:05.587937 :C0701FF7:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 09:42:05.587937 :C0701FF8:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 09:42:05.588418 :C0701FF9: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-08-16 09:42:05.588466 :C0702000: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-08-16 09:52:06.543080 :C070E582:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 09:52:06.907123 :C070E5C8:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 09:52:06.902 2025-08-16 09:52:06.907125 :C070E5C9:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=22140 pso_num=22 pso_serial#=26 2025-08-16 09:52:06.907260 :C070E5CA:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=22140 osp_idx=0 osp_ver=519533 osp_pg=0 (spawn #494128) 2025-08-16 09:52:06.907261 :C070E5CB:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 09:52:06.907261 :C070E5CC:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=40 time=4018596220 2025-08-16 09:52:06.907262 :C070E5CD:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 09:52:06.907262 :C070E5CE:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 09:52:06.907262 :C070E5CF:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 09:52:06.907263 :C070E5D0:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 09:52:06.907263 :C070E5D1:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 09:52:06.907790 :C070E5D2: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-08-16 09:52:06.907837 :C070E5DA: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-08-16 10:02:07.739102 :C071ADCF:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-08-16 10:02:08.134484 :C071AE08:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 08-16 10:02:08.129 2025-08-16 10:02:08.134486 :C071AE09:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=17340 pso_num=22 pso_serial#=27 2025-08-16 10:02:08.134627 :C071AE0A:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=17340 osp_idx=0 osp_ver=519534 osp_pg=0 (spawn #494153) 2025-08-16 10:02:08.134627 :C071AE0B:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-16 10:02:08.134628 :C071AE0C:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=41 time=4019197439 2025-08-16 10:02:08.134628 :C071AE0D:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-08-16 10:02:08.134629 :C071AE0E:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-08-16 10:02:08.134629 :C071AE0F:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-08-16 10:02:08.134629 :C071AE10:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-16 10:02:08.134630 :C071AE11:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-16 10:02:08.135137 :C071AE12: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-08-16 10:02:08.135183 :C071AE19: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-08-16 10:05:43.796921 :C071F769: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 17340, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de