Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250915220005\orcl_w000_19404_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250915220005\orcl_w000_19404_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:34717M/63366M, Ph+PgF:39306M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 19404, image: ORACLE.EXE (W000) *** 2025-09-15 22:00:05.224 *** SESSION ID:(201.10319) 2025-09-15 22:00:05.224 *** 2025-09-15 22:00:05.224 Process diagnostic dump for ORACLE.EXE (W000), OS id=19404, pid: 25, proc_ser: 224, sid: 201, sess_ser: 10319 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=80 seq_num=81 snap_id=1 wait times: snap=0.520652 sec, exc=0.520652 sec, total=0.520652 sec wait times: max=5.000000 sec, heur=6 min 36 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000027 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=79 seq_num=80 snap_id=1 wait times: snap=5.014815 sec, exc=5.014815 sec, total=5.014815 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000048 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=78 seq_num=79 snap_id=1 wait times: snap=5.010160 sec, exc=5.010160 sec, total=5.010160 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000047 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=77 seq_num=78 snap_id=1 wait times: snap=5.014692 sec, exc=5.014692 sec, total=5.014692 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000068 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=76 seq_num=77 snap_id=1 wait times: snap=5.008298 sec, exc=5.008298 sec, total=5.008298 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000052 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=75 seq_num=76 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.000063 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=74 seq_num=75 snap_id=1 wait times: snap=5.012802 sec, exc=5.012802 sec, total=5.012802 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000030 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=73 seq_num=74 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.000038 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=72 seq_num=73 snap_id=1 wait times: snap=5.004620 sec, exc=5.004620 sec, total=5.004620 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=5.014722 sec, exc=5.014722 sec, total=5.014722 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.007239 sec, exc=5.007239 sec, total=5.007239 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time Sampled Session History of session 201 serial 10319 --------------------------------------------------- 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:05 - 22:00:05] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-15 22:00:05.224 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 19404, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-15 19:23:09.455315 :CDDEB91E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 19:23:09.455315 :CDDEB91F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 19:23:09.455804 :CDDEB920: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-09-15 19:23:09.455848 :CDDEB927: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-09-15 19:33:10.406225 :CDDF82C3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 19:33:10.849360 :CDDF831E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 19:33:10.843 2025-09-15 19:33:10.849362 :CDDF831F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25040 pso_num=25 pso_serial#=211 2025-09-15 19:33:10.849531 :CDDF8320:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25040 osp_idx=23 osp_ver=300869 osp_pg=0 (spawn #595506) 2025-09-15 19:33:10.849532 :CDDF8321:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 19:33:10.849532 :CDDF8322:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=89 time=2350442158 2025-09-15 19:33:10.849533 :CDDF8323:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 19:33:10.849533 :CDDF8324:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 19:33:10.849534 :CDDF8325:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 19:33:10.849534 :CDDF8326:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 19:33:10.849534 :CDDF8327:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 19:33:10.850159 :CDDF8328: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-09-15 19:33:10.850234 :CDDF8332: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-09-15 19:43:11.732229 :CDE04ABB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 19:43:12.284101 :CDE04B06:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 19:43:12.279 2025-09-15 19:43:12.284103 :CDE04B07:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23668 pso_num=25 pso_serial#=212 2025-09-15 19:43:12.284245 :CDE04B08:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23668 osp_idx=23 osp_ver=300870 osp_pg=0 (spawn #595528) 2025-09-15 19:43:12.284246 :CDE04B09:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 19:43:12.284246 :CDE04B0A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=90 time=2351043580 2025-09-15 19:43:12.284247 :CDE04B0B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 19:43:12.284247 :CDE04B0C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 19:43:12.284247 :CDE04B0D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 19:43:12.284248 :CDE04B0E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 19:43:12.284248 :CDE04B0F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 19:43:12.284754 :CDE04B10: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-09-15 19:43:12.284799 :CDE04B19: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-09-15 19:53:13.136442 :CDE11267:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 19:53:13.750498 :CDE112BD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 19:53:13.745 2025-09-15 19:53:13.750500 :CDE112BE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=6364 pso_num=25 pso_serial#=213 2025-09-15 19:53:13.750636 :CDE112BF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=6364 osp_idx=23 osp_ver=300871 osp_pg=0 (spawn #595551) 2025-09-15 19:53:13.750637 :CDE112C0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 19:53:13.750638 :CDE112C1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=91 time=2351645049 2025-09-15 19:53:13.750638 :CDE112C2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 19:53:13.750638 :CDE112C3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 19:53:13.750639 :CDE112C4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 19:53:13.750640 :CDE112C5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 19:53:13.750640 :CDE112C6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 19:53:13.751133 :CDE112C7: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-09-15 19:53:13.751180 :CDE112CE: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-09-15 20:03:14.658979 :CDE1DE84:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 20:03:15.043895 :CDE1DEC9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 20:03:15.039 2025-09-15 20:03:15.043897 :CDE1DECA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23684 pso_num=25 pso_serial#=214 2025-09-15 20:03:15.044038 :CDE1DECB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23684 osp_idx=23 osp_ver=300872 osp_pg=0 (spawn #595577) 2025-09-15 20:03:15.044039 :CDE1DECC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 20:03:15.044040 :CDE1DECD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=92 time=2352246346 2025-09-15 20:03:15.044040 :CDE1DECE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 20:03:15.044040 :CDE1DECF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 20:03:15.044040 :CDE1DED0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 20:03:15.044041 :CDE1DED1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 20:03:15.044041 :CDE1DED2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 20:03:15.044551 :CDE1DED3: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-09-15 20:03:15.044601 :CDE1DEDC: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-09-15 20:13:15.890959 :CDE2B1DF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 20:13:16.364389 :CDE2B233:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 20:13:16.360 2025-09-15 20:13:16.364391 :CDE2B234:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21908 pso_num=25 pso_serial#=215 2025-09-15 20:13:16.364532 :CDE2B235:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21908 osp_idx=23 osp_ver=300873 osp_pg=0 (spawn #595599) 2025-09-15 20:13:16.364533 :CDE2B236:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 20:13:16.364533 :CDE2B237:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=93 time=2352847674 2025-09-15 20:13:16.364534 :CDE2B238:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 20:13:16.364534 :CDE2B239:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 20:13:16.364535 :CDE2B23A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 20:13:16.364535 :CDE2B23B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 20:13:16.364535 :CDE2B23C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 20:13:16.365031 :CDE2B23D: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-09-15 20:13:16.365076 :CDE2B245: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-09-15 20:23:17.388613 :CDE37BFD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 20:23:17.690454 :CDE37C3A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 20:23:17.686 2025-09-15 20:23:17.690456 :CDE37C3B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24936 pso_num=25 pso_serial#=216 2025-09-15 20:23:17.690599 :CDE37C3C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24936 osp_idx=23 osp_ver=300874 osp_pg=0 (spawn #595622) 2025-09-15 20:23:17.690600 :CDE37C3D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 20:23:17.690600 :CDE37C3E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=94 time=2353449002 2025-09-15 20:23:17.690601 :CDE37C3F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 20:23:17.690601 :CDE37C40:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 20:23:17.690602 :CDE37C41:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 20:23:17.690602 :CDE37C42:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 20:23:17.690602 :CDE37C43:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 20:23:17.691100 :CDE37C44: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-09-15 20:23:17.691146 :CDE37C4C: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-09-15 20:30:50.873987 :CDE413B7: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-09-15 20:33:19.059380 :CDE44647: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-09-15 20:43:19.952163 :CDE50F84:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 20:43:20.363334 :CDE50FC6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 20:43:20.358 2025-09-15 20:43:20.363337 :CDE50FC7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20048 pso_num=25 pso_serial#=217 2025-09-15 20:43:20.363475 :CDE50FC8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20048 osp_idx=23 osp_ver=300875 osp_pg=0 (spawn #595666) 2025-09-15 20:43:20.363476 :CDE50FC9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 20:43:20.363476 :CDE50FCA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=95 time=2354651674 2025-09-15 20:43:20.363477 :CDE50FCB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 20:43:20.363477 :CDE50FCC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 20:43:20.363477 :CDE50FCD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 20:43:20.363478 :CDE50FCE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 20:43:20.363478 :CDE50FCF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 20:43:20.363996 :CDE50FD0: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-09-15 20:43:20.364040 :CDE50FD8: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-09-15 20:53:21.258077 :CDE5D9B1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 20:53:21.507455 :CDE5D9E6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 20:53:21.502 2025-09-15 20:53:21.507456 :CDE5D9E7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24656 pso_num=25 pso_serial#=218 2025-09-15 20:53:21.507601 :CDE5D9E8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24656 osp_idx=23 osp_ver=300876 osp_pg=0 (spawn #595689) 2025-09-15 20:53:21.507602 :CDE5D9E9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 20:53:21.507602 :CDE5D9EA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=96 time=2355252815 2025-09-15 20:53:21.507603 :CDE5D9EB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 20:53:21.507603 :CDE5D9EC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 20:53:21.507604 :CDE5D9ED:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 20:53:21.507604 :CDE5D9EE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 20:53:21.507604 :CDE5D9EF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 20:53:21.508121 :CDE5D9F0: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-09-15 20:53:21.508177 :CDE5D9F9: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-09-15 21:03:22.347295 :CDE6A6B6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 21:03:22.773976 :CDE6A6FD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 21:03:22.768 2025-09-15 21:03:22.773978 :CDE6A6FE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23080 pso_num=25 pso_serial#=219 2025-09-15 21:03:22.774112 :CDE6A6FF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23080 osp_idx=23 osp_ver=300877 osp_pg=0 (spawn #595716) 2025-09-15 21:03:22.774112 :CDE6A700:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 21:03:22.774113 :CDE6A701:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=97 time=2355854080 2025-09-15 21:03:22.774114 :CDE6A702:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 21:03:22.774114 :CDE6A703:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 21:03:22.774115 :CDE6A704:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 21:03:22.774115 :CDE6A705:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 21:03:22.774116 :CDE6A706:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 21:03:22.774601 :CDE6A707: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-09-15 21:03:22.774647 :CDE6A710: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-09-15 21:13:23.638590 :CDE7767B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 21:13:23.903807 :CDE776AF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 21:13:23.899 2025-09-15 21:13:23.903809 :CDE776B0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23916 pso_num=25 pso_serial#=220 2025-09-15 21:13:23.903973 :CDE776B1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23916 osp_idx=23 osp_ver=300878 osp_pg=0 (spawn #595738) 2025-09-15 21:13:23.903974 :CDE776B2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 21:13:23.903975 :CDE776B3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=98 time=2356455205 2025-09-15 21:13:23.903975 :CDE776B4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 21:13:23.903977 :CDE776B5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 21:13:23.903977 :CDE776B6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 21:13:23.903978 :CDE776B7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 21:13:23.903978 :CDE776B8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 21:13:23.904579 :CDE776B9: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-09-15 21:13:23.904646 :CDE776BF: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-09-15 21:23:24.862375 :CDE842DB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 21:23:25.242058 :CDE84318:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 21:23:25.237 2025-09-15 21:23:25.242060 :CDE84319:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23280 pso_num=25 pso_serial#=221 2025-09-15 21:23:25.242203 :CDE8431A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23280 osp_idx=23 osp_ver=300879 osp_pg=0 (spawn #595761) 2025-09-15 21:23:25.242203 :CDE8431B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 21:23:25.242204 :CDE8431C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=99 time=2357056549 2025-09-15 21:23:25.242204 :CDE8431D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 21:23:25.242205 :CDE8431E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 21:23:25.242205 :CDE8431F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 21:23:25.242205 :CDE84320:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 21:23:25.242205 :CDE84321:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 21:23:25.242711 :CDE84322: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-09-15 21:23:25.242758 :CDE84329: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-09-15 21:33:26.151456 :CDE90D12:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 21:33:26.400894 :CDE90D7C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 21:33:26.396 2025-09-15 21:33:26.400896 :CDE90D7D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24712 pso_num=25 pso_serial#=222 2025-09-15 21:33:26.401044 :CDE90D7E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24712 osp_idx=23 osp_ver=300880 osp_pg=0 (spawn #595784) 2025-09-15 21:33:26.401045 :CDE90D7F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 21:33:26.401045 :CDE90D80:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=100 time=2357657705 2025-09-15 21:33:26.401046 :CDE90D81:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 21:33:26.401046 :CDE90D82:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 21:33:26.401047 :CDE90D83:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 21:33:26.401047 :CDE90D84:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 21:33:26.401047 :CDE90D85:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 21:33:26.401558 :CDE90D86: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-09-15 21:33:26.401607 :CDE90D8E: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-09-15 21:43:27.404190 :CDE9D6CA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 21:43:27.690112 :CDE9D728:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 21:43:27.685 2025-09-15 21:43:27.690114 :CDE9D729:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20860 pso_num=25 pso_serial#=223 2025-09-15 21:43:27.690249 :CDE9D72A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20860 osp_idx=23 osp_ver=300881 osp_pg=0 (spawn #595806) 2025-09-15 21:43:27.690250 :CDE9D72B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 21:43:27.690250 :CDE9D72C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=101 time=2358259002 2025-09-15 21:43:27.690251 :CDE9D72D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 21:43:27.690251 :CDE9D72E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 21:43:27.690252 :CDE9D72F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 21:43:27.690252 :CDE9D730:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 21:43:27.690252 :CDE9D731:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 21:43:27.690746 :CDE9D732: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-09-15 21:43:27.690793 :CDE9D73A: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-09-15 21:53:28.581458 :CDEAA050:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-15 21:53:29.060419 :CDEAA098:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-15 21:53:29.055 2025-09-15 21:53:29.060421 :CDEAA099:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19404 pso_num=25 pso_serial#=224 2025-09-15 21:53:29.060566 :CDEAA09A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19404 osp_idx=23 osp_ver=300882 osp_pg=0 (spawn #595829) 2025-09-15 21:53:29.060567 :CDEAA09B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-15 21:53:29.060567 :CDEAA09C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=102 time=2358860362 2025-09-15 21:53:29.060568 :CDEAA09D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-15 21:53:29.060568 :CDEAA09E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-15 21:53:29.060568 :CDEAA09F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-15 21:53:29.060569 :CDEAA0A0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-15 21:53:29.060569 :CDEAA0A1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-15 21:53:29.061107 :CDEAA0A2: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-09-15 21:53:29.061159 :CDEAA0A9: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: 19404, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de