Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250601140716\orcl_w000_15120_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250601140716\orcl_w000_15120_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:37166M/63366M, Ph+PgF:44019M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 22 Windows thread id: 15120, image: ORACLE.EXE (W000) *** 2025-06-01 14:07:17.000 *** SESSION ID:(177.17221) 2025-06-01 14:07:17.000 *** 2025-06-01 14:07:17.000 Process diagnostic dump for ORACLE.EXE (W000), OS id=15120, pid: 22, proc_ser: 223, sid: 177, sess_ser: 17221 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=3.748214 sec, exc=3.748214 sec, total=3.748214 sec wait times: max=5.000000 sec, heur=2 min 13 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.000024 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=26 seq_num=27 snap_id=1 wait times: snap=5.000677 sec, exc=5.000677 sec, total=5.000677 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=25 seq_num=26 snap_id=1 wait times: snap=5.001267 sec, exc=5.001267 sec, total=5.001267 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=24 seq_num=25 snap_id=1 wait times: snap=5.014234 sec, exc=5.014234 sec, total=5.014234 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=23 seq_num=24 snap_id=1 wait times: snap=5.006500 sec, exc=5.006500 sec, total=5.006500 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=22 seq_num=23 snap_id=1 wait times: snap=5.014719 sec, exc=5.014719 sec, total=5.014719 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=21 seq_num=22 snap_id=1 wait times: snap=5.004631 sec, exc=5.004631 sec, total=5.004631 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=20 seq_num=21 snap_id=1 wait times: snap=5.004626 sec, exc=5.004626 sec, total=5.004626 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=19 seq_num=20 snap_id=1 wait times: snap=5.009753 sec, exc=5.009753 sec, total=5.009753 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=18 seq_num=19 snap_id=1 wait times: snap=5.003460 sec, exc=5.003460 sec, total=5.003460 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=17 seq_num=18 snap_id=1 wait times: snap=5.014606 sec, exc=5.014606 sec, total=5.014606 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time Sampled Session History of session 177 serial 17221 --------------------------------------------------- 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, 14:05:17 - 14:07:17] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-01 14:07:17.000 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 22 (osid: 15120, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-01 11:54:45.506720 :9EDC712B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 11:54:45.506720 :9EDC712C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 11:54:45.506720 :9EDC712D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 11:54:45.507211 :9EDC712E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 11:54:45.507257 :9EDC7136:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 12:04:46.428824 :9EDD388F:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:04:46.917962 :9EDD38D9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:04:46.913 2025-06-01 12:04:46.917964 :9EDD38DA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13980 pso_num=22 pso_serial#=208 2025-06-01 12:04:46.918104 :9EDD38DB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13980 osp_idx=0 osp_ver=254260 osp_pg=0 (spawn #241112) 2025-06-01 12:04:46.918104 :9EDD38DC:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 12:04:46.918105 :9EDD38DD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=159 time=1755245563 2025-06-01 12:04:46.918105 :9EDD38DE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 12:04:46.918106 :9EDD38DF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 12:04:46.918106 :9EDD38E0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 12:04:46.918106 :9EDD38E1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 12:04:46.918107 :9EDD38E2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 12:04:46.918597 :9EDD38E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 12:04:46.918656 :9EDD38E9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 12:14:47.844701 :9EDE06A4:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:14:47.952688 :9EDE06B3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:14:47.938 2025-06-01 12:14:47.952689 :9EDE06B4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=10948 pso_num=22 pso_serial#=209 2025-06-01 12:14:47.952832 :9EDE06B5:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=10948 (legacy spawn) 2025-06-01 12:14:47.959292 :9EDE06B6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 12:14:47.959473 :9EDE06BB:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-01 12:14:47.960264 :9EDE06C0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:14:47.968898 :9EDE06C3:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:14:47.954 2025-06-01 12:14:47.968900 :9EDE06C4:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12380 pso_num=22 pso_serial#=210 2025-06-01 12:14:47.969036 :9EDE06C5:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=12380 (legacy spawn) 2025-06-01 12:14:47.975455 :9EDE06C6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 12:14:47.975621 :9EDE06CF:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-01 12:14:47.976393 :9EDE06D0:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:14:48.255648 :9EDE071C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:14:48.250 2025-06-01 12:14:48.255650 :9EDE071D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8164 pso_num=22 pso_serial#=211 2025-06-01 12:14:48.255782 :9EDE071E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8164 osp_idx=0 osp_ver=254263 osp_pg=0 (spawn #241135) 2025-06-01 12:14:48.255783 :9EDE071F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 12:14:48.255783 :9EDE0720:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=160 time=1755846907 2025-06-01 12:14:48.255784 :9EDE0721:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 12:14:48.255784 :9EDE0722:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 12:14:48.255785 :9EDE0723:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 12:14:48.255785 :9EDE0724:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 12:14:48.255786 :9EDE0725:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 12:14:48.256265 :9EDE0726:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 12:14:48.256310 :9EDE072D:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 12:24:49.144606 :9EDECC72:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:24:49.573455 :9EDECCA9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:24:49.568 2025-06-01 12:24:49.573457 :9EDECCAA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12756 pso_num=22 pso_serial#=212 2025-06-01 12:24:49.573603 :9EDECCAB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12756 osp_idx=0 osp_ver=254264 osp_pg=0 (spawn #241158) 2025-06-01 12:24:49.573603 :9EDECCAC:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 12:24:49.573603 :9EDECCAD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=161 time=1756448219 2025-06-01 12:24:49.573604 :9EDECCAE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 12:24:49.573604 :9EDECCAF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 12:24:49.573605 :9EDECCB0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 12:24:49.573605 :9EDECCB1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 12:24:49.573605 :9EDECCB2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 12:24:49.574124 :9EDECCB3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 12:24:49.574168 :9EDECCB9:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 12:34:50.564701 :9EDF9260:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:34:50.792028 :9EDF9263:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:34:50.782 2025-06-01 12:34:50.792030 :9EDF9264:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14016 pso_num=22 pso_serial#=213 2025-06-01 12:34:50.792164 :9EDF9265:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=14016 (legacy spawn) 2025-06-01 12:34:50.798560 :9EDF9266:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 12:34:50.798740 :9EDF926B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-01 12:34:50.799525 :9EDF9270:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:34:50.990931 :9EDF92A9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:34:50.986 2025-06-01 12:34:50.990933 :9EDF92AA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14520 pso_num=22 pso_serial#=214 2025-06-01 12:34:50.991082 :9EDF92AB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14520 osp_idx=0 osp_ver=254266 osp_pg=0 (spawn #241178) 2025-06-01 12:34:50.991083 :9EDF92AC:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 12:34:50.991083 :9EDF92AD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=162 time=1757049641 2025-06-01 12:34:50.991084 :9EDF92AE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 12:34:50.991084 :9EDF92AF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 12:34:50.991085 :9EDF92B0:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 12:34:50.991085 :9EDF92B1:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 12:34:50.991085 :9EDF92B2:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 12:34:50.991576 :9EDF92B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 12:34:50.991621 :9EDF92BB:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 12:44:51.947710 :9EE058EB:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:44:52.431324 :9EE05932:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:44:52.427 2025-06-01 12:44:52.431326 :9EE05933:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15064 pso_num=22 pso_serial#=215 2025-06-01 12:44:52.431463 :9EE05934:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15064 osp_idx=0 osp_ver=254267 osp_pg=0 (spawn #241201) 2025-06-01 12:44:52.431464 :9EE05935:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 12:44:52.431464 :9EE05936:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=163 time=1757651079 2025-06-01 12:44:52.431465 :9EE05937:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 12:44:52.431465 :9EE05938:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 12:44:52.431466 :9EE05939:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 12:44:52.431466 :9EE0593A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 12:44:52.431466 :9EE0593B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 12:44:52.431971 :9EE0593C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 12:44:52.432017 :9EE05943:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 12:54:53.401479 :9EE11F86:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 12:54:53.906261 :9EE11FD7:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 12:54:53.901 2025-06-01 12:54:53.906263 :9EE11FD8:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14856 pso_num=22 pso_serial#=216 2025-06-01 12:54:53.906398 :9EE11FD9:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14856 osp_idx=0 osp_ver=254268 osp_pg=0 (spawn #241224) 2025-06-01 12:54:53.906399 :9EE11FDA:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 12:54:53.906399 :9EE11FDB:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=164 time=1758252547 2025-06-01 12:54:53.906399 :9EE11FDC:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 12:54:53.906400 :9EE11FDD:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 12:54:53.906400 :9EE11FDE:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 12:54:53.906400 :9EE11FDF:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 12:54:53.906401 :9EE11FE0:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 12:54:53.906900 :9EE11FE1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 12:54:53.906946 :9EE11FE8:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 13:04:54.858595 :9EE1E810:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 13:04:55.250491 :9EE1E847:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 13:04:55.251 2025-06-01 13:04:55.250494 :9EE1E848:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8776 pso_num=22 pso_serial#=217 2025-06-01 13:04:55.250651 :9EE1E849:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=8776 osp_idx=0 osp_ver=254269 osp_pg=0 (spawn #241250) 2025-06-01 13:04:55.250652 :9EE1E84A:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 13:04:55.250653 :9EE1E84B:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=165 time=1758853891 2025-06-01 13:04:55.250653 :9EE1E84C:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 13:04:55.250654 :9EE1E84D:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 13:04:55.250654 :9EE1E84E:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 13:04:55.250654 :9EE1E84F:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 13:04:55.250654 :9EE1E850:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 13:04:55.251154 :9EE1E851:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 13:04:55.251195 :9EE1E859:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 13:14:56.158192 :9EE2B6BA:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 13:14:56.548052 :9EE2B6F9:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 13:14:56.543 2025-06-01 13:14:56.548054 :9EE2B6FA:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=9960 pso_num=22 pso_serial#=218 2025-06-01 13:14:56.548196 :9EE2B6FB:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=9960 osp_idx=0 osp_ver=254270 osp_pg=0 (spawn #241273) 2025-06-01 13:14:56.548196 :9EE2B6FC:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 13:14:56.548197 :9EE2B6FD:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=166 time=1759455188 2025-06-01 13:14:56.548198 :9EE2B6FE:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 13:14:56.548198 :9EE2B6FF:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 13:14:56.548198 :9EE2B700:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 13:14:56.548199 :9EE2B701:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 13:14:56.548199 :9EE2B702:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 13:14:56.548711 :9EE2B703:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 13:14:56.548761 :9EE2B70B:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 13:24:57.502669 :9EE37C3D:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 13:24:57.898013 :9EE37C74:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 13:24:57.893 2025-06-01 13:24:57.898015 :9EE37C75:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=12908 pso_num=22 pso_serial#=219 2025-06-01 13:24:57.898208 :9EE37C76:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=12908 osp_idx=0 osp_ver=254271 osp_pg=0 (spawn #241296) 2025-06-01 13:24:57.898209 :9EE37C77:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 13:24:57.898209 :9EE37C78:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=167 time=1760056547 2025-06-01 13:24:57.898209 :9EE37C79:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 13:24:57.898210 :9EE37C7A:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 13:24:57.898210 :9EE37C7B:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 13:24:57.898210 :9EE37C7C:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 13:24:57.898211 :9EE37C7D:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 13:24:57.898718 :9EE37C7E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 13:24:57.898766 :9EE37C85:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 13:30:01.246125 :9EE3E047:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-01 13:34:59.268650 :9EE442E2:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-01 13:45:00.195012 :9EE508E6:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 13:45:00.574617 :9EE5091C:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 13:45:00.570 2025-06-01 13:45:00.574619 :9EE5091D:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=14984 pso_num=22 pso_serial#=220 2025-06-01 13:45:00.574761 :9EE5091E:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=14984 osp_idx=0 osp_ver=254272 osp_pg=0 (spawn #241340) 2025-06-01 13:45:00.574761 :9EE5091F:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 13:45:00.574762 :9EE50920:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=168 time=1761259219 2025-06-01 13:45:00.574762 :9EE50921:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 13:45:00.574762 :9EE50922:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 13:45:00.574763 :9EE50923:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 13:45:00.574763 :9EE50924:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 13:45:00.574763 :9EE50925:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 13:45:00.575257 :9EE50926:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 13:45:00.575301 :9EE5092E:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 13:55:01.568423 :9EE5CFEE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 13:55:01.686357 :9EE5CFF1:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 13:55:01.677 2025-06-01 13:55:01.686360 :9EE5CFF2:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=8548 pso_num=22 pso_serial#=221 2025-06-01 13:55:01.686497 :9EE5CFF3:db_trace:kso.c@4070:ksonfy(): [10420:22:0] kso: new process: pid=8548 (legacy spawn) 2025-06-01 13:55:01.692870 :9EE5CFF4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 13:55:01.693054 :9EE5CFFD:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-06-01 13:55:01.693859 :9EE5CFFE:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 13:55:01.807467 :9EE5D035:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 13:55:01.802 2025-06-01 13:55:01.807469 :9EE5D036:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=13316 pso_num=22 pso_serial#=222 2025-06-01 13:55:01.807608 :9EE5D037:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=13316 osp_idx=0 osp_ver=254274 osp_pg=0 (spawn #241363) 2025-06-01 13:55:01.807610 :9EE5D038:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 13:55:01.807610 :9EE5D039:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=169 time=1761860454 2025-06-01 13:55:01.807610 :9EE5D03A:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 13:55:01.807610 :9EE5D03B:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 13:55:01.807611 :9EE5D03C:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 13:55:01.807611 :9EE5D03D:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 13:55:01.807612 :9EE5D03E:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 13:55:01.808122 :9EE5D03F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 13:55:01.808172 :9EE5D045:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 14:05:02.727597 :9EE69B40:db_trace:kst.c@698:kstpsodel(): [10280:22:0] kst: process state object about to be deleted 2025-06-01 14:05:03.060476 :9EE69B82:db_trace:kst.c@673:kstipg(): [10280:22:0] kst: process state object created on 06-01 14:05:03.056 2025-06-01 14:05:03.060478 :9EE69B83:db_trace:kst.c@679:kstipg(): [10280:22:0] kst: process info: ospid=15120 pso_num=22 pso_serial#=223 2025-06-01 14:05:03.060619 :9EE69B84:db_trace:kso.c@4093:ksonfy(): [10420:22:0] kso: new process: pid=15120 osp_idx=0 osp_ver=254275 osp_pg=0 (spawn #241388) 2025-06-01 14:05:03.060619 :9EE69B85:db_trace:kso.c@4099:ksonfy(): [10420:22:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 14:05:03.060620 :9EE69B86:db_trace:kso.c@4103:ksonfy(): [10420:22:0] kso: new process: pso_index=22 reservation=170 time=1762461704 2025-06-01 14:05:03.060621 :9EE69B87:db_trace:kso.c@4109:ksonfy(): [10420:22:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 14:05:03.060621 :9EE69B88:db_trace:kso.c@4111:ksonfy(): [10420:22:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 14:05:03.060622 :9EE69B89:db_trace:kso.c@4113:ksonfy(): [10420:22:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 14:05:03.060622 :9EE69B8A:db_trace:kso.c@4115:ksonfy(): [10420:22:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 14:05:03.060622 :9EE69B8B:db_trace:kso.c@4117:ksonfy(): [10420:22:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 14:05:03.061110 :9EE69B8C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:22:177] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 14:05:03.061153 :9EE69B92:db_trace:ksl2.c@12699:ksliwat(): [10005:22:177] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 22 (osid: 15120, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de