Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250525060008\orcl_w000_14684_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250525060008\orcl_w000_14684_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:37272M/63366M, Ph+PgF:44270M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 14684, image: ORACLE.EXE (W000) *** 2025-05-25 06:00:08.804 *** SESSION ID:(193.18661) 2025-05-25 06:00:08.804 *** 2025-05-25 06:00:08.804 Process diagnostic dump for ORACLE.EXE (W000), OS id=14684, pid: 24, proc_ser: 156, sid: 193, sess_ser: 18661 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=103 seq_num=104 snap_id=1 wait times: snap=1.485918 sec, exc=1.485918 sec, total=1.485918 sec wait times: max=5.000000 sec, heur=8 min 32 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.000023 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=102 seq_num=103 snap_id=1 wait times: snap=5.000263 sec, exc=5.000263 sec, total=5.000263 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000027 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=101 seq_num=102 snap_id=1 wait times: snap=5.000437 sec, exc=5.000437 sec, total=5.000437 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=100 seq_num=101 snap_id=1 wait times: snap=5.013883 sec, exc=5.013883 sec, total=5.013883 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=99 seq_num=100 snap_id=1 wait times: snap=5.014736 sec, exc=5.014736 sec, total=5.014736 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000020 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=98 seq_num=99 snap_id=1 wait times: snap=5.010134 sec, exc=5.010134 sec, total=5.010134 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=97 seq_num=98 snap_id=1 wait times: snap=5.009186 sec, exc=5.009186 sec, total=5.009186 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=96 seq_num=97 snap_id=1 wait times: snap=5.004615 sec, exc=5.004615 sec, total=5.004615 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000022 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=95 seq_num=96 snap_id=1 wait times: snap=5.007230 sec, exc=5.007230 sec, total=5.007230 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=94 seq_num=95 snap_id=1 wait times: snap=5.001319 sec, exc=5.001319 sec, total=5.001319 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=93 seq_num=94 snap_id=1 wait times: snap=5.014763 sec, exc=5.014763 sec, total=5.014763 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000019 sec of elapsed time Sampled Session History of session 193 serial 18661 --------------------------------------------------- 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, 05:58:08 - 06:00:08] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-25 06:00:08.804 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 14684, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-25 03:31:17.189278 :9BA2BF9D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9468 pso_num=24 pso_serial#=143 2025-05-25 03:31:17.189416 :9BA2BF9E:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9468 osp_idx=22 osp_ver=319402 osp_pg=0 (spawn #216599) 2025-05-25 03:31:17.189417 :9BA2BF9F:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 03:31:17.189417 :9BA2BFA0:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=246 time=1119649438 2025-05-25 03:31:17.189418 :9BA2BFA1:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 03:31:17.189418 :9BA2BFA2:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 03:31:17.189419 :9BA2BFA3:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 03:31:17.189419 :9BA2BFA4:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 03:31:17.189419 :9BA2BFA5:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 03:31:17.189902 :9BA2BFA6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 03:31:17.189957 :9BA2BFAC:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 03:41:18.245920 :9BA38428:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 03:41:18.532114 :9BA3846D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 03:41:18.527 2025-05-25 03:41:18.532115 :9BA3846E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13532 pso_num=24 pso_serial#=144 2025-05-25 03:41:18.532253 :9BA3846F:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13532 osp_idx=22 osp_ver=319403 osp_pg=0 (spawn #216619) 2025-05-25 03:41:18.532253 :9BA38470:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 03:41:18.532254 :9BA38471:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=247 time=1120250782 2025-05-25 03:41:18.532254 :9BA38472:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 03:41:18.532254 :9BA38473:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 03:41:18.532255 :9BA38474:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 03:41:18.532255 :9BA38475:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 03:41:18.532255 :9BA38476:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 03:41:18.532845 :9BA38477:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 03:41:18.532895 :9BA38481:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 03:51:19.536597 :9BA4491C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 03:51:19.806749 :9BA44951:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 03:51:19.802 2025-05-25 03:51:19.806751 :9BA44952:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=11376 pso_num=24 pso_serial#=145 2025-05-25 03:51:19.806883 :9BA44953:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=11376 osp_idx=22 osp_ver=319404 osp_pg=0 (spawn #216642) 2025-05-25 03:51:19.806885 :9BA44954:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 03:51:19.806885 :9BA44955:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=248 time=1120852063 2025-05-25 03:51:19.806886 :9BA44956:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 03:51:19.806886 :9BA44957:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 03:51:19.806886 :9BA44958:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 03:51:19.806887 :9BA44959:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 03:51:19.806887 :9BA4495A:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 03:51:19.807382 :9BA4495B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 03:51:19.807425 :9BA44964:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:01:20.850090 :9BA51225:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 04:01:21.151689 :9BA5125C:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 04:01:21.146 2025-05-25 04:01:21.151691 :9BA5125D:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13364 pso_num=24 pso_serial#=146 2025-05-25 04:01:21.151829 :9BA5125E:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13364 osp_idx=22 osp_ver=319405 osp_pg=0 (spawn #216667) 2025-05-25 04:01:21.151830 :9BA5125F:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 04:01:21.151830 :9BA51260:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=249 time=1121453407 2025-05-25 04:01:21.151830 :9BA51261:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 04:01:21.151831 :9BA51262:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 04:01:21.151831 :9BA51263:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 04:01:21.151831 :9BA51264:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 04:01:21.151832 :9BA51265:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 04:01:21.152321 :9BA51266:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 04:01:21.152368 :9BA5126D:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:11:22.113331 :9BA5DD28:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 04:11:22.508528 :9BA5DD61:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 04:11:22.503 2025-05-25 04:11:22.508530 :9BA5DD62:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9668 pso_num=24 pso_serial#=147 2025-05-25 04:11:22.508674 :9BA5DD63:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9668 osp_idx=22 osp_ver=319406 osp_pg=0 (spawn #216690) 2025-05-25 04:11:22.508674 :9BA5DD64:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 04:11:22.508675 :9BA5DD65:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=250 time=1122054766 2025-05-25 04:11:22.508675 :9BA5DD66:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 04:11:22.508676 :9BA5DD67:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 04:11:22.508676 :9BA5DD68:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 04:11:22.508676 :9BA5DD69:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 04:11:22.508677 :9BA5DD6A:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 04:11:22.509183 :9BA5DD6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 04:11:22.509227 :9BA5DD72:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:15:55.963183 :9BA63722:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:21:23.702497 :9BA6A521:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:31:24.730537 :9BA76943:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 04:31:25.078927 :9BA76978:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 04:31:25.074 2025-05-25 04:31:25.078929 :9BA76979:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=6600 pso_num=24 pso_serial#=148 2025-05-25 04:31:25.079069 :9BA7697A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=6600 osp_idx=22 osp_ver=319407 osp_pg=0 (spawn #216735) 2025-05-25 04:31:25.079070 :9BA7697B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 04:31:25.079072 :9BA7697C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=251 time=1123257329 2025-05-25 04:31:25.079072 :9BA7697D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 04:31:25.079072 :9BA7697E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 04:31:25.079073 :9BA7697F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 04:31:25.079073 :9BA76980:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 04:31:25.079073 :9BA76981:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 04:31:25.079563 :9BA76982:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 04:31:25.079607 :9BA7698B:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:31:40.113867 :9BA76E72:db_trace:ksl2.c@2477:kslwtbctx(): [10005:24:193] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-05-25 04:31:40.113872 :9BA76E77:db_trace:ksl2.c@2611:kslwtectx(): [10005:24:193] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=4 seq_num=5 snap_id=1 2025-05-25 04:31:40.113873 :9BA76E78:db_trace:ksl2.c@2619:kslwtectx(): [10005:24:193] KSL WAIT END wait times (usecs) - snap=7, exc=7, tot=7 2025-05-25 04:31:40.113882 :9BA76E79:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:41:26.057596 :9BA82EE5:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 04:41:26.374789 :9BA82F18:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 04:41:26.370 2025-05-25 04:41:26.374792 :9BA82F19:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14648 pso_num=24 pso_serial#=149 2025-05-25 04:41:26.374945 :9BA82F1A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=14648 osp_idx=22 osp_ver=319408 osp_pg=0 (spawn #216757) 2025-05-25 04:41:26.374946 :9BA82F1B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 04:41:26.374947 :9BA82F1C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=252 time=1123858625 2025-05-25 04:41:26.374947 :9BA82F1D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 04:41:26.374948 :9BA82F1E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 04:41:26.374948 :9BA82F1F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 04:41:26.374948 :9BA82F20:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 04:41:26.374949 :9BA82F21:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 04:41:26.375487 :9BA82F22:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 04:41:26.375538 :9BA82F2B:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 04:51:27.315059 :9BA8F328:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 04:51:27.804108 :9BA8F378:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 04:51:27.799 2025-05-25 04:51:27.804110 :9BA8F379:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13364 pso_num=24 pso_serial#=150 2025-05-25 04:51:27.804254 :9BA8F37A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13364 osp_idx=22 osp_ver=319409 osp_pg=0 (spawn #216778) 2025-05-25 04:51:27.804255 :9BA8F37B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 04:51:27.804256 :9BA8F37C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=253 time=1124460063 2025-05-25 04:51:27.804256 :9BA8F37D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 04:51:27.804257 :9BA8F37E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 04:51:27.804257 :9BA8F37F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 04:51:27.804258 :9BA8F380:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 04:51:27.804258 :9BA8F381:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 04:51:27.804761 :9BA8F382:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 04:51:27.804806 :9BA8F38A:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 05:01:28.786246 :9BA9BC6E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 05:01:29.212801 :9BA9BCAD:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 05:01:29.208 2025-05-25 05:01:29.212802 :9BA9BCAE:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14872 pso_num=24 pso_serial#=151 2025-05-25 05:01:29.212946 :9BA9BCAF:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=14872 osp_idx=22 osp_ver=319410 osp_pg=0 (spawn #216803) 2025-05-25 05:01:29.212948 :9BA9BCB0:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 05:01:29.212949 :9BA9BCB1:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=254 time=1125061469 2025-05-25 05:01:29.212949 :9BA9BCB2:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 05:01:29.212949 :9BA9BCB3:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 05:01:29.212950 :9BA9BCB4:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 05:01:29.212950 :9BA9BCB5:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 05:01:29.212950 :9BA9BCB6:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 05:01:29.213446 :9BA9BCB7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 05:01:29.213493 :9BA9BCBE:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 05:11:30.207397 :9BAA88C0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 05:11:30.649631 :9BAA8908:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 05:11:30.644 2025-05-25 05:11:30.649633 :9BAA8909:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13364 pso_num=24 pso_serial#=152 2025-05-25 05:11:30.649770 :9BAA890A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13364 osp_idx=22 osp_ver=319411 osp_pg=0 (spawn #216826) 2025-05-25 05:11:30.649771 :9BAA890B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 05:11:30.649772 :9BAA890C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=255 time=1125662907 2025-05-25 05:11:30.649772 :9BAA890D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 05:11:30.649772 :9BAA890E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 05:11:30.649773 :9BAA890F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 05:11:30.649773 :9BAA8910:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 05:11:30.649774 :9BAA8911:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 05:11:30.650261 :9BAA8912:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 05:11:30.650305 :9BAA8919:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 05:21:31.641937 :9BAB4D98:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 05:21:32.099729 :9BAB4DD2:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 05:21:32.095 2025-05-25 05:21:32.099731 :9BAB4DD3:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12276 pso_num=24 pso_serial#=153 2025-05-25 05:21:32.099872 :9BAB4DD4:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12276 osp_idx=22 osp_ver=319412 osp_pg=0 (spawn #216849) 2025-05-25 05:21:32.099873 :9BAB4DD5:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 05:21:32.099874 :9BAB4DD6:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=0 time=1126264360 2025-05-25 05:21:32.099874 :9BAB4DD7:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 05:21:32.099875 :9BAB4DD8:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 05:21:32.099875 :9BAB4DD9:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 05:21:32.099875 :9BAB4DDA:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 05:21:32.099876 :9BAB4DDB:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 05:21:32.100378 :9BAB4DDC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 05:21:32.100423 :9BAB4DE4:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 05:31:33.013984 :9BAC133C:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 05:31:33.565572 :9BAC1371:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 05:31:33.560 2025-05-25 05:31:33.565574 :9BAC1372:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13904 pso_num=24 pso_serial#=154 2025-05-25 05:31:33.565711 :9BAC1373:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13904 osp_idx=22 osp_ver=319413 osp_pg=0 (spawn #216872) 2025-05-25 05:31:33.565711 :9BAC1374:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 05:31:33.565712 :9BAC1375:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=1 time=1126865813 2025-05-25 05:31:33.565712 :9BAC1376:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 05:31:33.565713 :9BAC1377:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 05:31:33.565713 :9BAC1378:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 05:31:33.565713 :9BAC1379:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 05:31:33.565714 :9BAC137A:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 05:31:33.566213 :9BAC137B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 05:31:33.566257 :9BAC1383:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 05:41:34.541348 :9BACD762:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 05:41:35.077335 :9BACD7A9:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 05:41:35.072 2025-05-25 05:41:35.077337 :9BACD7AA:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15136 pso_num=24 pso_serial#=155 2025-05-25 05:41:35.077474 :9BACD7AB:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15136 osp_idx=22 osp_ver=319414 osp_pg=0 (spawn #216894) 2025-05-25 05:41:35.077475 :9BACD7AC:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 05:41:35.077475 :9BACD7AD:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=2 time=1127467329 2025-05-25 05:41:35.077476 :9BACD7AE:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 05:41:35.077476 :9BACD7AF:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 05:41:35.077476 :9BACD7B0:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 05:41:35.077477 :9BACD7B1:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 05:41:35.077477 :9BACD7B2:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 05:41:35.077968 :9BACD7B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 05:41:35.078012 :9BACD7BA:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-25 05:51:35.991696 :9BAD9CFF:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-05-25 05:51:36.512010 :9BAD9D42:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 05-25 05:51:36.507 2025-05-25 05:51:36.512012 :9BAD9D43:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14684 pso_num=24 pso_serial#=156 2025-05-25 05:51:36.512149 :9BAD9D44:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=14684 osp_idx=22 osp_ver=319415 osp_pg=0 (spawn #216917) 2025-05-25 05:51:36.512150 :9BAD9D45:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-25 05:51:36.512150 :9BAD9D46:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=3 time=1128068766 2025-05-25 05:51:36.512151 :9BAD9D47:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-05-25 05:51:36.512152 :9BAD9D48:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-05-25 05:51:36.512152 :9BAD9D49:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-05-25 05:51:36.512152 :9BAD9D4A:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-25 05:51:36.512152 :9BAD9D4B:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-25 05:51:36.512649 :9BAD9D4C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-25 05:51:36.512695 :9BAD9D55:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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 24 (osid: 14684, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de