Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250706180141\orcl_w000_4764_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250706180141\orcl_w000_4764_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:37010M/63366M, Ph+PgF:43026M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 4764, image: ORACLE.EXE (W000) *** 2025-07-06 18:01:41.716 *** SESSION ID:(201.16391) 2025-07-06 18:01:41.716 *** 2025-07-06 18:01:41.716 Process diagnostic dump for ORACLE.EXE (W000), OS id=4764, pid: 25, proc_ser: 101, sid: 201, sess_ser: 16391 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=32 seq_num=33 snap_id=1 wait times: snap=2.320315 sec, exc=2.320315 sec, total=2.320315 sec wait times: max=5.000000 sec, heur=2 min 37 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.000020 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=5.008288 sec, exc=5.008288 sec, total=5.008288 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000049 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=30 seq_num=31 snap_id=1 wait times: snap=5.008445 sec, exc=5.008445 sec, total=5.008445 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000041 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=5.005498 sec, exc=5.005498 sec, total=5.005498 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=28 seq_num=29 snap_id=1 wait times: snap=5.004607 sec, exc=5.004607 sec, total=5.004607 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=5.009735 sec, exc=5.009735 sec, total=5.009735 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=26 seq_num=27 snap_id=1 wait times: snap=5.002142 sec, exc=5.002142 sec, total=5.002142 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=25 seq_num=26 snap_id=1 wait times: snap=5.001412 sec, exc=5.001412 sec, total=5.001412 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=24 seq_num=25 snap_id=1 wait times: snap=5.000268 sec, exc=5.000268 sec, total=5.000268 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=23 seq_num=24 snap_id=1 wait times: snap=5.002533 sec, exc=5.002533 sec, total=5.002533 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=22 seq_num=23 snap_id=1 wait times: snap=5.004644 sec, exc=5.004644 sec, total=5.004644 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time Sampled Session History of session 201 serial 16391 --------------------------------------------------- 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, 17:59:41 - 18:01:41] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-06 18:01:41.716 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 4764, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-06 15:18:43.822218 :AE5B5248: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-07-06 15:28:44.637398 :AE5C1C18:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 15:28:45.034081 :AE5C1C80:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 15:28:45.029 2025-07-06 15:28:45.034084 :AE5C1C81:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15740 pso_num=25 pso_serial#=88 2025-07-06 15:28:45.034220 :AE5C1C82:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15740 osp_idx=23 osp_ver=185075 osp_pg=0 (spawn #358267) 2025-07-06 15:28:45.034221 :AE5C1C83:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 15:28:45.034221 :AE5C1C84:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=226 time=496500923 2025-07-06 15:28:45.034222 :AE5C1C85:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 15:28:45.034222 :AE5C1C86:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 15:28:45.034223 :AE5C1C87:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 15:28:45.034223 :AE5C1C88:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 15:28:45.034223 :AE5C1C89:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 15:28:45.034741 :AE5C1C8A: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-07-06 15:28:45.034783 :AE5C1C91: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-07-06 15:31:10.558516 :AE5C4D3D:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-06 15:38:46.283079 :AE5CE7AE:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-06 15:48:47.211560 :AE5DB105:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 15:48:47.513218 :AE5DB171:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 15:48:47.508 2025-07-06 15:48:47.513220 :AE5DB172:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13624 pso_num=25 pso_serial#=89 2025-07-06 15:48:47.513358 :AE5DB173:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13624 osp_idx=23 osp_ver=185076 osp_pg=0 (spawn #358311) 2025-07-06 15:48:47.513359 :AE5DB174:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 15:48:47.513359 :AE5DB175:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=227 time=497703408 2025-07-06 15:48:47.513360 :AE5DB176:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 15:48:47.513360 :AE5DB177:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 15:48:47.513360 :AE5DB178:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 15:48:47.513361 :AE5DB179:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 15:48:47.513361 :AE5DB17A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 15:48:47.513911 :AE5DB17B: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-07-06 15:48:47.513954 :AE5DB183: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-07-06 15:58:48.372587 :AE5E7B80:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 15:58:48.784712 :AE5E7BD7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 15:58:48.780 2025-07-06 15:58:48.784714 :AE5E7BD8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9900 pso_num=25 pso_serial#=90 2025-07-06 15:58:48.784860 :AE5E7BD9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9900 osp_idx=23 osp_ver=185077 osp_pg=0 (spawn #358334) 2025-07-06 15:58:48.784861 :AE5E7BDA:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 15:58:48.784861 :AE5E7BDB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=228 time=498304673 2025-07-06 15:58:48.784861 :AE5E7BDC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 15:58:48.784862 :AE5E7BDD:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 15:58:48.784862 :AE5E7BDE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 15:58:48.784862 :AE5E7BDF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 15:58:48.784863 :AE5E7BE0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 15:58:48.785379 :AE5E7BE1: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-07-06 15:58:48.785431 :AE5E7BE8: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-07-06 16:08:49.704821 :AE5F4EF9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 16:08:50.037653 :AE5F4F5F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 16:08:50.033 2025-07-06 16:08:50.037656 :AE5F4F60:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11036 pso_num=25 pso_serial#=91 2025-07-06 16:08:50.037851 :AE5F4F61:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11036 osp_idx=23 osp_ver=185078 osp_pg=0 (spawn #358361) 2025-07-06 16:08:50.037851 :AE5F4F62:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 16:08:50.037852 :AE5F4F63:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=229 time=498905939 2025-07-06 16:08:50.037852 :AE5F4F64:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 16:08:50.037853 :AE5F4F65:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 16:08:50.037853 :AE5F4F66:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 16:08:50.037853 :AE5F4F67:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 16:08:50.037854 :AE5F4F68:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 16:08:50.038392 :AE5F4F69: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-07-06 16:08:50.038436 :AE5F4F70: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-07-06 16:18:50.911433 :AE601BCE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 16:18:51.275594 :AE601C47:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 16:18:51.271 2025-07-06 16:18:51.275596 :AE601C48:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18364 pso_num=25 pso_serial#=92 2025-07-06 16:18:51.275744 :AE601C49:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18364 osp_idx=23 osp_ver=185079 osp_pg=0 (spawn #358383) 2025-07-06 16:18:51.275745 :AE601C4A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 16:18:51.275746 :AE601C4B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=230 time=499507173 2025-07-06 16:18:51.275746 :AE601C4C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 16:18:51.275746 :AE601C4D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 16:18:51.275747 :AE601C4E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 16:18:51.275747 :AE601C4F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 16:18:51.275747 :AE601C50:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 16:18:51.276348 :AE601C51: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-07-06 16:18:51.276394 :AE601C58: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-07-06 16:28:52.134871 :AE60E5D0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 16:28:52.452407 :AE60E654:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 16:28:52.447 2025-07-06 16:28:52.452409 :AE60E655:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=316 pso_num=25 pso_serial#=93 2025-07-06 16:28:52.452539 :AE60E656:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=316 osp_idx=23 osp_ver=185080 osp_pg=0 (spawn #358406) 2025-07-06 16:28:52.452540 :AE60E657:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 16:28:52.452541 :AE60E658:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=231 time=500108345 2025-07-06 16:28:52.452541 :AE60E659:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 16:28:52.452541 :AE60E65A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 16:28:52.452542 :AE60E65B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 16:28:52.452542 :AE60E65C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 16:28:52.452542 :AE60E65D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 16:28:52.453138 :AE60E65E: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-07-06 16:28:52.453184 :AE60E666: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-07-06 16:38:53.256618 :AE61AF32:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 16:38:53.636794 :AE61AFB0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 16:38:53.636 2025-07-06 16:38:53.636796 :AE61AFB1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6008 pso_num=25 pso_serial#=94 2025-07-06 16:38:53.636946 :AE61AFB2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6008 osp_idx=23 osp_ver=185081 osp_pg=0 (spawn #358429) 2025-07-06 16:38:53.636947 :AE61AFB3:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 16:38:53.636947 :AE61AFB4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=232 time=500709533 2025-07-06 16:38:53.636947 :AE61AFB5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 16:38:53.636948 :AE61AFB6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 16:38:53.636948 :AE61AFB7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 16:38:53.636949 :AE61AFB8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 16:38:53.636949 :AE61AFB9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 16:38:53.637568 :AE61AFBA: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-07-06 16:38:53.637628 :AE61AFC0: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-07-06 16:48:54.428853 :AE627962:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 16:48:54.934720 :AE6279DB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 16:48:54.930 2025-07-06 16:48:54.934722 :AE6279DC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18064 pso_num=25 pso_serial#=95 2025-07-06 16:48:54.934865 :AE6279DD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18064 osp_idx=23 osp_ver=185082 osp_pg=0 (spawn #358451) 2025-07-06 16:48:54.934866 :AE6279DE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 16:48:54.934867 :AE6279DF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=233 time=501310829 2025-07-06 16:48:54.934867 :AE6279E0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 16:48:54.934868 :AE6279E1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 16:48:54.934868 :AE6279E2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 16:48:54.934869 :AE6279E3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 16:48:54.934869 :AE6279E4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 16:48:54.935466 :AE6279E5: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-07-06 16:48:54.935516 :AE6279EF: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-07-06 16:58:55.912456 :AE63429F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 16:58:56.151806 :AE6342E0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 16:58:56.147 2025-07-06 16:58:56.151808 :AE6342E1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17160 pso_num=25 pso_serial#=96 2025-07-06 16:58:56.151937 :AE6342E2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17160 osp_idx=23 osp_ver=185083 osp_pg=0 (spawn #358474) 2025-07-06 16:58:56.151938 :AE6342E3:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 16:58:56.151938 :AE6342E4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=234 time=501912048 2025-07-06 16:58:56.151939 :AE6342E5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 16:58:56.151939 :AE6342E6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 16:58:56.151939 :AE6342E7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 16:58:56.151940 :AE6342E8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 16:58:56.151940 :AE6342E9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 16:58:56.152495 :AE6342EA: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-07-06 16:58:56.152538 :AE6342F1: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-07-06 17:08:57.045805 :AE6417F1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 17:08:57.425653 :AE641836:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 17:08:57.420 2025-07-06 17:08:57.425655 :AE641837:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17340 pso_num=25 pso_serial#=97 2025-07-06 17:08:57.425793 :AE641838:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17340 osp_idx=23 osp_ver=185084 osp_pg=0 (spawn #358500) 2025-07-06 17:08:57.425793 :AE641839:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 17:08:57.425794 :AE64183A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=235 time=502513314 2025-07-06 17:08:57.425794 :AE64183B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 17:08:57.425795 :AE64183C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 17:08:57.425795 :AE64183D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 17:08:57.425795 :AE64183E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 17:08:57.425796 :AE64183F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 17:08:57.426309 :AE641840: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-07-06 17:08:57.426355 :AE641847: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-07-06 17:18:58.323908 :AE64E213:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 17:18:58.781922 :AE64E271:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 17:18:58.777 2025-07-06 17:18:58.781924 :AE64E272:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8520 pso_num=25 pso_serial#=98 2025-07-06 17:18:58.782060 :AE64E273:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8520 osp_idx=23 osp_ver=185085 osp_pg=0 (spawn #358522) 2025-07-06 17:18:58.782060 :AE64E274:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 17:18:58.782061 :AE64E275:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=236 time=503114673 2025-07-06 17:18:58.782061 :AE64E276:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 17:18:58.782061 :AE64E277:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 17:18:58.782062 :AE64E278:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 17:18:58.782062 :AE64E279:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 17:18:58.782062 :AE64E27A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 17:18:58.782599 :AE64E27B: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-07-06 17:18:58.782650 :AE64E282: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-07-06 17:28:59.703459 :AE65AC3E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 17:29:00.036440 :AE65AC86:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 17:29:00.031 2025-07-06 17:29:00.036442 :AE65AC87:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6736 pso_num=25 pso_serial#=99 2025-07-06 17:29:00.036585 :AE65AC88:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6736 osp_idx=23 osp_ver=185086 osp_pg=0 (spawn #358545) 2025-07-06 17:29:00.036586 :AE65AC89:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 17:29:00.036586 :AE65AC8A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=237 time=503715923 2025-07-06 17:29:00.036586 :AE65AC8B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 17:29:00.036587 :AE65AC8C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 17:29:00.036589 :AE65AC8D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 17:29:00.036590 :AE65AC8E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 17:29:00.036590 :AE65AC8F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 17:29:00.037115 :AE65AC90: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-07-06 17:29:00.037161 :AE65AC97: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-07-06 17:36:11.255696 :AE663D6C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-06 17:39:01.379003 :AE6676D7:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-06 17:49:02.240292 :AE67412D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 17:49:02.729283 :AE674173:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 17:49:02.724 2025-07-06 17:49:02.729285 :AE674174:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4556 pso_num=25 pso_serial#=100 2025-07-06 17:49:02.729425 :AE674175:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4556 osp_idx=23 osp_ver=185087 osp_pg=0 (spawn #358589) 2025-07-06 17:49:02.729426 :AE674176:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 17:49:02.729426 :AE674177:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=238 time=504918626 2025-07-06 17:49:02.729427 :AE674178:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 17:49:02.729427 :AE674179:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 17:49:02.729427 :AE67417A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 17:49:02.729428 :AE67417B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 17:49:02.729428 :AE67417C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 17:49:02.729950 :AE67417D: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-07-06 17:49:02.730008 :AE674183: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-07-06 17:59:03.644348 :AE680AFB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-06 17:59:04.164807 :AE680B48:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-06 17:59:04.160 2025-07-06 17:59:04.164809 :AE680B49:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4764 pso_num=25 pso_serial#=101 2025-07-06 17:59:04.164949 :AE680B4A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4764 osp_idx=23 osp_ver=185088 osp_pg=0 (spawn #358612) 2025-07-06 17:59:04.164949 :AE680B4B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-06 17:59:04.164949 :AE680B4C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=239 time=505520064 2025-07-06 17:59:04.164949 :AE680B4D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-06 17:59:04.164950 :AE680B4E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-06 17:59:04.164950 :AE680B4F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-06 17:59:04.164950 :AE680B50:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-06 17:59:04.164951 :AE680B51:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-06 17:59:04.165471 :AE680B52: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-07-06 17:59:04.165523 :AE680B5A: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: 4764, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de