Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250916220010\orcl_w000_25392_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250916220010\orcl_w000_25392_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:35962M/63366M, Ph+PgF:40312M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 25392, image: ORACLE.EXE (W000) *** 2025-09-16 22:00:10.191 *** SESSION ID:(201.13187) 2025-09-16 22:00:10.191 *** 2025-09-16 22:00:10.191 Process diagnostic dump for ORACLE.EXE (W000), OS id=25392, pid: 25, proc_ser: 9, sid: 201, sess_ser: 13187 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=44 seq_num=45 snap_id=1 wait times: snap=0.473469 sec, exc=0.473469 sec, total=0.473469 sec wait times: max=5.000000 sec, heur=3 min 35 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000037 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=43 seq_num=44 snap_id=1 wait times: snap=5.001491 sec, exc=5.001491 sec, total=5.001491 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=42 seq_num=43 snap_id=1 wait times: snap=5.014293 sec, exc=5.014293 sec, total=5.014293 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=41 seq_num=42 snap_id=1 wait times: snap=5.014857 sec, exc=5.014857 sec, total=5.014857 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=40 seq_num=41 snap_id=1 wait times: snap=5.004656 sec, exc=5.004656 sec, total=5.004656 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=39 seq_num=40 snap_id=1 wait times: snap=5.015301 sec, exc=5.015301 sec, total=5.015301 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000036 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=38 seq_num=39 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.000033 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=37 seq_num=38 snap_id=1 wait times: snap=5.009775 sec, exc=5.009775 sec, total=5.009775 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=36 seq_num=37 snap_id=1 wait times: snap=5.003234 sec, exc=5.003234 sec, total=5.003234 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=35 seq_num=36 snap_id=1 wait times: snap=5.008792 sec, exc=5.008792 sec, total=5.008792 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=34 seq_num=35 snap_id=1 wait times: snap=5.008270 sec, exc=5.008270 sec, total=5.008270 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 13187 --------------------------------------------------- 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:10 - 22:00:10] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-16 22:00:10.191 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 25392, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-16 19:26:15.710168 :CE515523:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 19:26:15.710168 :CE515524:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 19:26:15.710769 :CE515525: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-16 19:26:15.710820 :CE51552C: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-16 19:36:16.537258 :CE521D6D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 19:36:16.917183 :CE521DAE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 19:36:16.912 2025-09-16 19:36:16.917185 :CE521DAF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=21592 pso_num=25 pso_serial#=251 2025-09-16 19:36:16.917324 :CE521DB0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=21592 osp_idx=23 osp_ver=302184 osp_pg=0 (spawn #598851) 2025-09-16 19:36:16.917324 :CE521DB1: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-16 19:36:16.917325 :CE521DB2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=189 time=2437028221 2025-09-16 19:36:16.917325 :CE521DB3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 19:36:16.917325 :CE521DB4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 19:36:16.917326 :CE521DB5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 19:36:16.917326 :CE521DB6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 19:36:16.917326 :CE521DB7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 19:36:16.917887 :CE521DB8: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-16 19:36:16.917935 :CE521DBE: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-16 19:46:17.718774 :CE52E606:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 19:46:18.192530 :CE52E653:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 19:46:18.188 2025-09-16 19:46:18.192533 :CE52E654:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23868 pso_num=25 pso_serial#=252 2025-09-16 19:46:18.192671 :CE52E655:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23868 osp_idx=23 osp_ver=302185 osp_pg=0 (spawn #598873) 2025-09-16 19:46:18.192672 :CE52E656: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-16 19:46:18.192672 :CE52E657:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=190 time=2437629502 2025-09-16 19:46:18.192673 :CE52E658:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 19:46:18.192673 :CE52E659:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 19:46:18.192673 :CE52E65A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 19:46:18.192674 :CE52E65B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 19:46:18.192674 :CE52E65C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 19:46:18.193228 :CE52E65D: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-16 19:46:18.193280 :CE52E664: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-16 19:56:19.078193 :CE53AE8D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 19:56:19.458819 :CE53AECE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 19:56:19.453 2025-09-16 19:56:19.458821 :CE53AECF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25568 pso_num=25 pso_serial#=253 2025-09-16 19:56:19.458965 :CE53AED0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25568 osp_idx=23 osp_ver=302186 osp_pg=0 (spawn #598896) 2025-09-16 19:56:19.458966 :CE53AED1: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-16 19:56:19.458966 :CE53AED2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=191 time=2438230768 2025-09-16 19:56:19.458966 :CE53AED3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 19:56:19.458967 :CE53AED4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 19:56:19.458967 :CE53AED5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 19:56:19.458968 :CE53AED6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 19:56:19.458968 :CE53AED7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 19:56:19.459580 :CE53AED8: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-16 19:56:19.459647 :CE53AEE2: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-16 20:06:20.382221 :CE547FB7:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 20:06:20.684147 :CE548005:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 20:06:20.679 2025-09-16 20:06:20.684149 :CE548006:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25536 pso_num=25 pso_serial#=254 2025-09-16 20:06:20.684294 :CE548007:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25536 osp_idx=23 osp_ver=302187 osp_pg=0 (spawn #598922) 2025-09-16 20:06:20.684294 :CE548008: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-16 20:06:20.684295 :CE548009:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=192 time=2438831987 2025-09-16 20:06:20.684295 :CE54800A:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 20:06:20.684296 :CE54800B:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 20:06:20.684296 :CE54800C:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 20:06:20.684296 :CE54800D:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 20:06:20.684297 :CE54800E:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 20:06:20.684830 :CE54800F: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-16 20:06:20.684877 :CE548016: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-16 20:16:21.691670 :CE5547E0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 20:16:21.977712 :CE55481E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 20:16:21.973 2025-09-16 20:16:21.977714 :CE55481F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23812 pso_num=25 pso_serial#=255 2025-09-16 20:16:21.977852 :CE554820:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23812 osp_idx=23 osp_ver=302188 osp_pg=0 (spawn #598944) 2025-09-16 20:16:21.977853 :CE554821: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-16 20:16:21.977853 :CE554822:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=193 time=2439433283 2025-09-16 20:16:21.977853 :CE554823:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 20:16:21.977854 :CE554824:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 20:16:21.977854 :CE554825:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 20:16:21.977854 :CE554826:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 20:16:21.977855 :CE554827:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 20:16:21.978357 :CE554828: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-16 20:16:21.978406 :CE55482F: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-16 20:26:22.792071 :CE56126F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 20:26:23.125556 :CE5612BC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 20:26:23.120 2025-09-16 20:26:23.125558 :CE5612BD:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24412 pso_num=25 pso_serial#=1 2025-09-16 20:26:23.125708 :CE5612BE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24412 osp_idx=23 osp_ver=302189 osp_pg=0 (spawn #598967) 2025-09-16 20:26:23.125709 :CE5612BF: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-16 20:26:23.125709 :CE5612C0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=194 time=2440034424 2025-09-16 20:26:23.125710 :CE5612C1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 20:26:23.125710 :CE5612C2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 20:26:23.125710 :CE5612C3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 20:26:23.125711 :CE5612C4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 20:26:23.125711 :CE5612C5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 20:26:23.126311 :CE5612C6: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-16 20:26:23.126357 :CE5612CE: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-16 20:36:23.976916 :CE56DB46:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 20:36:24.388382 :CE56DB88:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 20:36:24.383 2025-09-16 20:36:24.388384 :CE56DB89:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20568 pso_num=25 pso_serial#=2 2025-09-16 20:36:24.388521 :CE56DB8A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20568 osp_idx=23 osp_ver=302190 osp_pg=0 (spawn #598990) 2025-09-16 20:36:24.388522 :CE56DB8B: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-16 20:36:24.388522 :CE56DB8C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=195 time=2440635690 2025-09-16 20:36:24.388522 :CE56DB8D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 20:36:24.388523 :CE56DB8E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 20:36:24.388523 :CE56DB8F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 20:36:24.388523 :CE56DB90:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 20:36:24.388524 :CE56DB91:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 20:36:24.389105 :CE56DB92: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-16 20:36:24.389149 :CE56DB9A: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-16 20:46:25.335968 :CE57A412:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 20:46:25.622020 :CE57A463:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 20:46:25.617 2025-09-16 20:46:25.622021 :CE57A464:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19552 pso_num=25 pso_serial#=3 2025-09-16 20:46:25.622167 :CE57A465:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19552 osp_idx=23 osp_ver=302191 osp_pg=0 (spawn #599012) 2025-09-16 20:46:25.622168 :CE57A466: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-16 20:46:25.622169 :CE57A467:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=196 time=2441236924 2025-09-16 20:46:25.622169 :CE57A468:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 20:46:25.622169 :CE57A469:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 20:46:25.622169 :CE57A46A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 20:46:25.622170 :CE57A46B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 20:46:25.622170 :CE57A46C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 20:46:25.622805 :CE57A46D: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-16 20:46:25.622855 :CE57A476: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-16 20:56:26.457114 :CE586C2D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 20:56:26.743879 :CE586C79:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 20:56:26.743 2025-09-16 20:56:26.743881 :CE586C7A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25204 pso_num=25 pso_serial#=4 2025-09-16 20:56:26.744023 :CE586C7B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25204 osp_idx=23 osp_ver=302192 osp_pg=0 (spawn #599036) 2025-09-16 20:56:26.744024 :CE586C7C: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-16 20:56:26.744024 :CE586C7D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=197 time=2441838049 2025-09-16 20:56:26.744025 :CE586C7E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 20:56:26.744025 :CE586C7F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 20:56:26.744026 :CE586C80:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 20:56:26.744026 :CE586C81:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 20:56:26.744026 :CE586C82:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 20:56:26.744578 :CE586C83: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-16 20:56:26.744623 :CE586C8A: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-16 21:05:04.409851 :CE591C19: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-16 21:06:28.042733 :CE593F72: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-16 21:16:28.959093 :CE5A09B5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 21:16:29.323789 :CE5A0A0B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 21:16:29.318 2025-09-16 21:16:29.323791 :CE5A0A0C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=24028 pso_num=25 pso_serial#=5 2025-09-16 21:16:29.323939 :CE5A0A0D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=24028 osp_idx=23 osp_ver=302193 osp_pg=0 (spawn #599083) 2025-09-16 21:16:29.323941 :CE5A0A0E: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-16 21:16:29.323941 :CE5A0A0F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=198 time=2443040627 2025-09-16 21:16:29.323942 :CE5A0A10:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 21:16:29.323942 :CE5A0A11:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 21:16:29.323942 :CE5A0A12:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 21:16:29.323943 :CE5A0A13:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 21:16:29.323943 :CE5A0A14:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 21:16:29.324516 :CE5A0A15: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-16 21:16:29.324563 :CE5A0A1D: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-16 21:26:30.199474 :CE5AD739:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 21:26:30.580722 :CE5AD784:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 21:26:30.575 2025-09-16 21:26:30.580724 :CE5AD785:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=23636 pso_num=25 pso_serial#=6 2025-09-16 21:26:30.580914 :CE5AD786:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=23636 osp_idx=23 osp_ver=302194 osp_pg=0 (spawn #599106) 2025-09-16 21:26:30.580915 :CE5AD787: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-16 21:26:30.580916 :CE5AD788:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=199 time=2443641877 2025-09-16 21:26:30.580916 :CE5AD789:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 21:26:30.580917 :CE5AD78A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 21:26:30.580917 :CE5AD78B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 21:26:30.580918 :CE5AD78C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 21:26:30.580918 :CE5AD78D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 21:26:30.581624 :CE5AD78E: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-16 21:26:30.581698 :CE5AD798: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-16 21:36:31.416446 :CE5BA1BF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 21:36:31.843421 :CE5BA20B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 21:36:31.838 2025-09-16 21:36:31.843423 :CE5BA20C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20612 pso_num=25 pso_serial#=7 2025-09-16 21:36:31.843566 :CE5BA20D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20612 osp_idx=23 osp_ver=302195 osp_pg=0 (spawn #599129) 2025-09-16 21:36:31.843567 :CE5BA20E: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-16 21:36:31.843567 :CE5BA20F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=200 time=2444243143 2025-09-16 21:36:31.843568 :CE5BA210:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 21:36:31.843568 :CE5BA211:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 21:36:31.843568 :CE5BA212:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 21:36:31.843569 :CE5BA213:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 21:36:31.843569 :CE5BA214:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 21:36:31.844155 :CE5BA215: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-16 21:36:31.844209 :CE5BA21D: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-16 21:46:32.677621 :CE5C6C61:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 21:46:33.068007 :CE5C6CCF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 21:46:33.063 2025-09-16 21:46:33.068009 :CE5C6CD0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25212 pso_num=25 pso_serial#=8 2025-09-16 21:46:33.068156 :CE5C6CD1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25212 osp_idx=23 osp_ver=302196 osp_pg=0 (spawn #599151) 2025-09-16 21:46:33.068157 :CE5C6CD2: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-16 21:46:33.068158 :CE5C6CD3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=201 time=2444844377 2025-09-16 21:46:33.068158 :CE5C6CD4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 21:46:33.068159 :CE5C6CD5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 21:46:33.068159 :CE5C6CD6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 21:46:33.068160 :CE5C6CD7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 21:46:33.068160 :CE5C6CD8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 21:46:33.068754 :CE5C6CD9: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-16 21:46:33.068802 :CE5C6CE1: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-16 21:56:33.979916 :CE5D374F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-09-16 21:56:34.422522 :CE5D37AD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 09-16 21:56:34.417 2025-09-16 21:56:34.422524 :CE5D37AE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=25392 pso_num=25 pso_serial#=9 2025-09-16 21:56:34.422666 :CE5D37AF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=25392 osp_idx=23 osp_ver=302197 osp_pg=0 (spawn #599174) 2025-09-16 21:56:34.422667 :CE5D37B0: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-16 21:56:34.422667 :CE5D37B1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=202 time=2445445721 2025-09-16 21:56:34.422668 :CE5D37B2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-09-16 21:56:34.422668 :CE5D37B3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-09-16 21:56:34.422668 :CE5D37B4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-09-16 21:56:34.422669 :CE5D37B5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-16 21:56:34.422669 :CE5D37B6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-16 21:56:34.423264 :CE5D37B7: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-16 21:56:34.423309 :CE5D37BF: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: 25392, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de