Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250516220403\orcl_w000_9964_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250516220403\orcl_w000_9964_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:37410M/63366M, Ph+PgF:44634M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 9964, image: ORACLE.EXE (W000) *** 2025-05-16 22:04:03.630 *** SESSION ID:(201.18995) 2025-05-16 22:04:03.630 *** 2025-05-16 22:04:03.630 Process diagnostic dump for ORACLE.EXE (W000), OS id=9964, pid: 25, proc_ser: 204, sid: 201, sess_ser: 18995 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=114 seq_num=115 snap_id=1 wait times: snap=3.400476 sec, exc=3.400476 sec, total=3.400476 sec wait times: max=5.000000 sec, heur=9 min 29 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.000028 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=113 seq_num=114 snap_id=1 wait times: snap=5.010143 sec, exc=5.010143 sec, total=5.010143 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=112 seq_num=113 snap_id=1 wait times: snap=5.014709 sec, exc=5.014709 sec, total=5.014709 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=111 seq_num=112 snap_id=1 wait times: snap=5.004634 sec, exc=5.004634 sec, total=5.004634 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=110 seq_num=111 snap_id=1 wait times: snap=5.008342 sec, exc=5.008342 sec, total=5.008342 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=109 seq_num=110 snap_id=1 wait times: snap=5.010950 sec, exc=5.010950 sec, total=5.010950 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=108 seq_num=109 snap_id=1 wait times: snap=5.011070 sec, exc=5.011070 sec, total=5.011070 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000031 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=107 seq_num=108 snap_id=1 wait times: snap=5.010149 sec, exc=5.010149 sec, total=5.010149 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=106 seq_num=107 snap_id=1 wait times: snap=5.009203 sec, exc=5.009203 sec, total=5.009203 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=105 seq_num=106 snap_id=1 wait times: snap=5.004633 sec, exc=5.004633 sec, total=5.004633 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=104 seq_num=105 snap_id=1 wait times: snap=5.015231 sec, exc=5.015231 sec, total=5.015231 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time Sampled Session History of session 201 serial 18995 --------------------------------------------------- The sampled session history is constructed by sampling the target session every 1 second. The sampling process captures at each sample if the session is in a non-idle wait, an idle wait, or not in a wait. If the session is in a non-idle wait then one interval is shown for all the samples the session was in the same non-idle wait. If the session is in an idle wait or not in a wait for consecutive samples then one interval is shown for all the consecutive samples. Though we display these consecutive samples in a single interval the session may NOT be continuously idle or not in a wait (the sampling process does not know). The history is displayed in reverse chronological order. sample interval: 1 sec, max history 120 sec --------------------------------------------------- [121 samples, 22:02:03 - 22:04:03] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-16 22:04:03.630 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 9964, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-16 19:34:16.120912 :97F88C20:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 19:34:16.120913 :97F88C21:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 19:34:16.120913 :97F88C22:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 19:34:16.120914 :97F88C23:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 19:34:16.121402 :97F88C24: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-05-16 19:34:16.121445 :97F88C2B: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-05-16 19:44:17.020387 :97F95027:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 19:44:17.447166 :97F9507F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 19:44:17.443 2025-05-16 19:44:17.447168 :97F95080:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8928 pso_num=25 pso_serial#=191 2025-05-16 19:44:17.447304 :97F95081:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8928 osp_idx=23 osp_ver=96835 osp_pg=0 (spawn #188838) 2025-05-16 19:44:17.447304 :97F95082:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 19:44:17.447305 :97F95083:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=192 time=400467313 2025-05-16 19:44:17.447305 :97F95084:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 19:44:17.447306 :97F95085:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 19:44:17.447306 :97F95086:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 19:44:17.447306 :97F95087:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 19:44:17.447306 :97F95088:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 19:44:17.447797 :97F95089: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-05-16 19:44:17.447842 :97F95091: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-05-16 19:54:18.364922 :97FA1446:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 19:54:18.650981 :97FA14A6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 19:54:18.646 2025-05-16 19:54:18.650983 :97FA14A7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10268 pso_num=25 pso_serial#=192 2025-05-16 19:54:18.651118 :97FA14A8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10268 osp_idx=23 osp_ver=96836 osp_pg=0 (spawn #188861) 2025-05-16 19:54:18.651118 :97FA14A9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 19:54:18.651119 :97FA14AA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=193 time=401068516 2025-05-16 19:54:18.651119 :97FA14AB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 19:54:18.651119 :97FA14AC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 19:54:18.651120 :97FA14AD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 19:54:18.651120 :97FA14AE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 19:54:18.651120 :97FA14AF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 19:54:18.651603 :97FA14B0: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-05-16 19:54:18.651659 :97FA14B7: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-05-16 20:04:19.564328 :97FADB8F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 20:04:19.811313 :97FADBBE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 20:04:19.798 2025-05-16 20:04:19.811315 :97FADBBF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11732 pso_num=25 pso_serial#=193 2025-05-16 20:04:19.811462 :97FADBC0:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=11732 (legacy spawn) 2025-05-16 20:04:19.818185 :97FADBC1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-05-16 20:04:19.818369 :97FADBCA:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-16 20:04:19.819234 :97FADBCB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 20:04:19.881302 :97FADC00:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 20:04:19.876 2025-05-16 20:04:19.881304 :97FADC01:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11468 pso_num=25 pso_serial#=194 2025-05-16 20:04:19.881435 :97FADC02:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11468 osp_idx=23 osp_ver=96838 osp_pg=0 (spawn #188887) 2025-05-16 20:04:19.881436 :97FADC03:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 20:04:19.881436 :97FADC04:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=194 time=401669750 2025-05-16 20:04:19.881437 :97FADC05:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 20:04:19.881437 :97FADC06:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 20:04:19.881437 :97FADC07:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 20:04:19.881438 :97FADC08:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 20:04:19.881438 :97FADC09:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 20:04:19.881942 :97FADC0A: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-05-16 20:04:19.881987 :97FADC12: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-05-16 20:14:20.802966 :97FBA5E1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 20:14:21.135865 :97FBA62A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 20:14:21.130 2025-05-16 20:14:21.135867 :97FBA62B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13572 pso_num=25 pso_serial#=195 2025-05-16 20:14:21.136001 :97FBA62C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13572 osp_idx=23 osp_ver=96839 osp_pg=0 (spawn #188909) 2025-05-16 20:14:21.136002 :97FBA62D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 20:14:21.136002 :97FBA62E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=195 time=402271000 2025-05-16 20:14:21.136003 :97FBA62F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 20:14:21.136003 :97FBA630:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 20:14:21.136003 :97FBA631:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 20:14:21.136004 :97FBA632:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 20:14:21.136004 :97FBA633:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 20:14:21.136513 :97FBA634: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-05-16 20:14:21.136557 :97FBA63D: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-05-16 20:24:22.118963 :97FC6DB3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 20:24:22.404976 :97FC6E08:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 20:24:22.400 2025-05-16 20:24:22.404978 :97FC6E09:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2404 pso_num=25 pso_serial#=196 2025-05-16 20:24:22.405119 :97FC6E0A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2404 osp_idx=23 osp_ver=96840 osp_pg=0 (spawn #188932) 2025-05-16 20:24:22.405120 :97FC6E0B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 20:24:22.405121 :97FC6E0C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=196 time=402872282 2025-05-16 20:24:22.405121 :97FC6E0D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 20:24:22.405121 :97FC6E0E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 20:24:22.405122 :97FC6E0F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 20:24:22.405122 :97FC6E10:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 20:24:22.405122 :97FC6E11:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 20:24:22.405635 :97FC6E12: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-05-16 20:24:22.405683 :97FC6E1A: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-05-16 20:24:52.461270 :97FC77F6:db_trace:ksl2.c@2477:kslwtbctx(): [10005:25:201] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=7 seq_num=8 snap_id=1 2025-05-16 20:24:52.461275 :97FC77FB:db_trace:ksl2.c@2611:kslwtectx(): [10005:25:201] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=7 seq_num=8 snap_id=1 2025-05-16 20:24:52.461276 :97FC77FC:db_trace:ksl2.c@2619:kslwtectx(): [10005:25:201] KSL WAIT END wait times (usecs) - snap=6, exc=6, tot=6 2025-05-16 20:24:52.461287 :97FC77FD: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-05-16 20:34:23.393962 :97FD33A1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 20:34:23.726743 :97FD33E8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 20:34:23.722 2025-05-16 20:34:23.726745 :97FD33E9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14076 pso_num=25 pso_serial#=197 2025-05-16 20:34:23.726885 :97FD33EA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14076 osp_idx=23 osp_ver=96841 osp_pg=0 (spawn #188955) 2025-05-16 20:34:23.726886 :97FD33EB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 20:34:23.726886 :97FD33EC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=197 time=403473594 2025-05-16 20:34:23.726887 :97FD33ED:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 20:34:23.726887 :97FD33EE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 20:34:23.726888 :97FD33EF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 20:34:23.726888 :97FD33F0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 20:34:23.726888 :97FD33F1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 20:34:23.727381 :97FD33F2: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-05-16 20:34:23.727427 :97FD33F9: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-05-16 20:44:24.608609 :97FDF8F1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 20:44:25.004020 :97FDF938:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 20:44:24.999 2025-05-16 20:44:25.004022 :97FDF939:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2404 pso_num=25 pso_serial#=198 2025-05-16 20:44:25.004161 :97FDF93A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2404 osp_idx=23 osp_ver=96842 osp_pg=0 (spawn #188977) 2025-05-16 20:44:25.004162 :97FDF93B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 20:44:25.004162 :97FDF93C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=198 time=404074875 2025-05-16 20:44:25.004163 :97FDF93D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 20:44:25.004163 :97FDF93E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 20:44:25.004163 :97FDF93F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 20:44:25.004164 :97FDF940:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 20:44:25.004164 :97FDF941:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 20:44:25.004675 :97FDF942: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-05-16 20:44:25.004718 :97FDF949: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-05-16 20:54:25.975688 :97FEBE11:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 20:54:26.277246 :97FEBE55:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 20:54:26.272 2025-05-16 20:54:26.277248 :97FEBE56:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13572 pso_num=25 pso_serial#=199 2025-05-16 20:54:26.277384 :97FEBE57:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13572 osp_idx=23 osp_ver=96843 osp_pg=0 (spawn #189000) 2025-05-16 20:54:26.277384 :97FEBE58:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 20:54:26.277385 :97FEBE59:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=199 time=404676141 2025-05-16 20:54:26.277385 :97FEBE5A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 20:54:26.277386 :97FEBE5B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 20:54:26.277386 :97FEBE5C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 20:54:26.277386 :97FEBE5D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 20:54:26.277387 :97FEBE5E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 20:54:26.277877 :97FEBE5F: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-05-16 20:54:26.277920 :97FEBE66: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-05-16 20:59:26.535052 :97FF20A3: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-05-16 21:04:27.584629 :97FF8686: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-05-16 21:14:28.540505 :9800548B:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 21:14:28.841928 :980054CB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 21:14:28.837 2025-05-16 21:14:28.841931 :980054CC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3624 pso_num=25 pso_serial#=200 2025-05-16 21:14:28.842106 :980054CD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3624 osp_idx=23 osp_ver=96844 osp_pg=0 (spawn #189047) 2025-05-16 21:14:28.842107 :980054CE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 21:14:28.842107 :980054CF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=200 time=405878719 2025-05-16 21:14:28.842108 :980054D0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 21:14:28.842108 :980054D1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 21:14:28.842109 :980054D2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 21:14:28.842109 :980054D3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 21:14:28.842109 :980054D4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 21:14:28.842612 :980054D5: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-05-16 21:14:28.842656 :980054DD: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-05-16 21:24:29.724363 :98011ADD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 21:24:30.150879 :98011B17:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 21:24:30.146 2025-05-16 21:24:30.150881 :98011B18:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12612 pso_num=25 pso_serial#=201 2025-05-16 21:24:30.151018 :98011B19:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12612 osp_idx=23 osp_ver=96845 osp_pg=0 (spawn #189070) 2025-05-16 21:24:30.151019 :98011B1A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 21:24:30.151019 :98011B1B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=201 time=406480016 2025-05-16 21:24:30.151020 :98011B1C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 21:24:30.151020 :98011B1D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 21:24:30.151021 :98011B1E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 21:24:30.151022 :98011B1F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 21:24:30.151022 :98011B20:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 21:24:30.151501 :98011B21: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-05-16 21:24:30.151546 :98011B29: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-05-16 21:34:31.079099 :9801E0AC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 21:34:31.552586 :9801E0F3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 21:34:31.548 2025-05-16 21:34:31.552589 :9801E0F4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9964 pso_num=25 pso_serial#=202 2025-05-16 21:34:31.552731 :9801E0F5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9964 osp_idx=23 osp_ver=96846 osp_pg=0 (spawn #189093) 2025-05-16 21:34:31.552732 :9801E0F6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 21:34:31.552733 :9801E0F7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=202 time=407081422 2025-05-16 21:34:31.552733 :9801E0F8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 21:34:31.552734 :9801E0F9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 21:34:31.552734 :9801E0FA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 21:34:31.552734 :9801E0FB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 21:34:31.552735 :9801E0FC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 21:34:31.553232 :9801E0FD: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-05-16 21:34:31.553281 :9801E105: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-05-16 21:44:32.466824 :9802A573:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 21:44:32.903600 :9802A5AD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 21:44:32.898 2025-05-16 21:44:32.903602 :9802A5AE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12548 pso_num=25 pso_serial#=203 2025-05-16 21:44:32.903745 :9802A5AF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12548 osp_idx=23 osp_ver=96847 osp_pg=0 (spawn #189115) 2025-05-16 21:44:32.903746 :9802A5B0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 21:44:32.903746 :9802A5B1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=203 time=407682766 2025-05-16 21:44:32.903747 :9802A5B2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 21:44:32.903747 :9802A5B3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 21:44:32.903747 :9802A5B4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 21:44:32.903748 :9802A5B5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 21:44:32.903748 :9802A5B6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 21:44:32.904249 :9802A5B7: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-05-16 21:44:32.904299 :9802A5BE: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-05-16 21:54:33.912808 :98036AAC:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-16 21:54:34.325923 :98036AF3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-16 21:54:34.321 2025-05-16 21:54:34.325925 :98036AF4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9964 pso_num=25 pso_serial#=204 2025-05-16 21:54:34.326057 :98036AF5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9964 osp_idx=23 osp_ver=96848 osp_pg=0 (spawn #189138) 2025-05-16 21:54:34.326058 :98036AF6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-16 21:54:34.326058 :98036AF7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=204 time=408284188 2025-05-16 21:54:34.326059 :98036AF8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-16 21:54:34.326059 :98036AF9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-16 21:54:34.326059 :98036AFA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-16 21:54:34.326060 :98036AFB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-16 21:54:34.326060 :98036AFC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-16 21:54:34.326588 :98036AFD: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-05-16 21:54:34.326631 :98036B06: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: 9964, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de