Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504100104\orcl_w000_10608_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250504100104\orcl_w000_10608_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:37589M/63366M, Ph+PgF:45132M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 10608, image: ORACLE.EXE (W000) *** 2025-05-04 10:01:05.076 *** SESSION ID:(201.34965) 2025-05-04 10:01:05.076 *** 2025-05-04 10:01:05.076 Process diagnostic dump for ORACLE.EXE (W000), OS id=10608, pid: 25, proc_ser: 103, sid: 201, sess_ser: 34965 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=78 seq_num=79 snap_id=1 wait times: snap=3.648866 sec, exc=3.648866 sec, total=3.648866 sec wait times: max=5.000000 sec, heur=6 min 29 sec wait counts: calls=1 os=1 in_wait=1 iflags=0x5a8 Wait State: fixed_waits=0 flags=0x22 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.000034 sec since current wait 0: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=77 seq_num=78 snap_id=1 wait times: snap=5.003326 sec, exc=5.003326 sec, total=5.003326 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000030 sec of elapsed time 1: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=76 seq_num=77 snap_id=1 wait times: snap=5.000233 sec, exc=5.000233 sec, total=5.000233 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=75 seq_num=76 snap_id=1 wait times: snap=5.008220 sec, exc=5.008220 sec, total=5.008220 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000041 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=74 seq_num=75 snap_id=1 wait times: snap=5.003962 sec, exc=5.003962 sec, total=5.003962 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000037 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=73 seq_num=74 snap_id=1 wait times: snap=5.014720 sec, exc=5.014720 sec, total=5.014720 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 5: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=72 seq_num=73 snap_id=1 wait times: snap=5.010123 sec, exc=5.010123 sec, total=5.010123 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000042 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=71 seq_num=72 snap_id=1 wait times: snap=5.014676 sec, exc=5.014676 sec, total=5.014676 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000078 sec of elapsed time 7: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=70 seq_num=71 snap_id=1 wait times: snap=5.001678 sec, exc=5.001678 sec, total=5.001678 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000034 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=69 seq_num=70 snap_id=1 wait times: snap=5.001249 sec, exc=5.001249 sec, total=5.001249 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000033 sec of elapsed time 9: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=68 seq_num=69 snap_id=1 wait times: snap=5.000290 sec, exc=5.000290 sec, total=5.000290 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 201 serial 34965 --------------------------------------------------- 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, 09:59:05 - 10:01:05] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-05-04 10:01:05.076 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 10608, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-05-04 07:24:19.116068 :92792577:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 07:24:19.111 2025-05-04 07:24:19.116070 :92792578:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10572 pso_num=25 pso_serial#=90 2025-05-04 07:24:19.116202 :92792579:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10572 osp_idx=23 osp_ver=74549 osp_pg=0 (spawn #146672) 2025-05-04 07:24:19.116203 :9279257A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 07:24:19.116203 :9279257B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=227 time=3614236281 2025-05-04 07:24:19.116203 :9279257C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 07:24:19.116204 :9279257D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 07:24:19.116204 :9279257E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 07:24:19.116205 :9279257F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 07:24:19.116205 :92792580:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 07:24:19.116749 :92792581:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 07:24:19.116795 :92792588:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 07:34:19.942209 :9279EB0D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 07:34:20.603037 :9279EB78:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 07:34:20.598 2025-05-04 07:34:20.603039 :9279EB79:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11552 pso_num=25 pso_serial#=91 2025-05-04 07:34:20.603181 :9279EB7A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11552 osp_idx=23 osp_ver=74550 osp_pg=0 (spawn #146695) 2025-05-04 07:34:20.603182 :9279EB7B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 07:34:20.603182 :9279EB7C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=228 time=3614837765 2025-05-04 07:34:20.603183 :9279EB7D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 07:34:20.603183 :9279EB7E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 07:34:20.603184 :9279EB7F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 07:34:20.603184 :9279EB80:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 07:34:20.603184 :9279EB81:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 07:34:20.603694 :9279EB82:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 07:34:20.603748 :9279EB8B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 07:44:21.470395 :927AB1D4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 07:44:21.959465 :927AB23B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 07:44:21.955 2025-05-04 07:44:21.959467 :927AB23C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10952 pso_num=25 pso_serial#=92 2025-05-04 07:44:21.959613 :927AB23D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10952 osp_idx=23 osp_ver=74551 osp_pg=0 (spawn #146717) 2025-05-04 07:44:21.959613 :927AB23E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 07:44:21.959614 :927AB23F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=229 time=3615439125 2025-05-04 07:44:21.959614 :927AB240:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 07:44:21.959615 :927AB241:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 07:44:21.959615 :927AB242:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 07:44:21.959615 :927AB243:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 07:44:21.959616 :927AB244:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 07:44:21.960120 :927AB245:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 07:44:21.960165 :927AB24C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 07:54:20.381305 :927B7736:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-04 07:54:20.381341 :927B7737:db_trace:ksl2.c@2477:kslwtbctx(): [10005:25:201] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=121 seq_num=122 snap_id=1 2025-05-04 07:54:20.381374 :927B773C:db_trace:ksl2.c@2611:kslwtectx(): [10005:25:201] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=121 seq_num=122 snap_id=1 2025-05-04 07:54:20.381375 :927B773D:db_trace:ksl2.c@2619:kslwtectx(): [10005:25:201] KSL WAIT END wait times (usecs) - snap=33, exc=33, tot=33 2025-05-04 08:04:21.304864 :927C3ED5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 08:04:21.668662 :927C3F3D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 08:04:21.664 2025-05-04 08:04:21.668664 :927C3F3E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10572 pso_num=25 pso_serial#=93 2025-05-04 08:04:21.668792 :927C3F3F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10572 osp_idx=23 osp_ver=74552 osp_pg=0 (spawn #146767) 2025-05-04 08:04:21.668793 :927C3F40:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:04:21.668793 :927C3F41:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=230 time=3616638828 2025-05-04 08:04:21.668793 :927C3F42:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:04:21.668794 :927C3F43:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:04:21.668794 :927C3F44:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:04:21.668795 :927C3F45:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:04:21.668795 :927C3F46:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:04:21.669271 :927C3F47:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:04:21.669320 :927C3F4F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 08:14:22.545393 :927D09EE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 08:14:23.018583 :927D0A49:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 08:14:23.014 2025-05-04 08:14:23.018585 :927D0A4A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3772 pso_num=25 pso_serial#=94 2025-05-04 08:14:23.018726 :927D0A4B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3772 osp_idx=23 osp_ver=74553 osp_pg=0 (spawn #146789) 2025-05-04 08:14:23.018727 :927D0A4C:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:14:23.018727 :927D0A4D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=231 time=3617240187 2025-05-04 08:14:23.018728 :927D0A4E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:14:23.018729 :927D0A4F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:14:23.018729 :927D0A50:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:14:23.018729 :927D0A51:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:14:23.018730 :927D0A52:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:14:23.019223 :927D0A53:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:14:23.019267 :927D0A5A:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 08:24:23.863383 :927E5659:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 08:24:24.362112 :927E56BF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 08:24:24.357 2025-05-04 08:24:24.362114 :927E56C0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=1192 pso_num=25 pso_serial#=95 2025-05-04 08:24:24.362249 :927E56C1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=1192 osp_idx=23 osp_ver=74554 osp_pg=0 (spawn #146819) 2025-05-04 08:24:24.362250 :927E56C2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:24:24.362250 :927E56C3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=232 time=3617841531 2025-05-04 08:24:24.362251 :927E56C4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:24:24.362251 :927E56C5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:24:24.362251 :927E56C6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:24:24.362252 :927E56C7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:24:24.362252 :927E56C8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:24:24.362791 :927E56C9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:24:24.362834 :927E56D1:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 08:34:25.276545 :927F3B2C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 08:34:25.656183 :927F3BB3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 08:34:25.651 2025-05-04 08:34:25.656185 :927F3BB4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10200 pso_num=25 pso_serial#=96 2025-05-04 08:34:25.656323 :927F3BB5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10200 osp_idx=23 osp_ver=74555 osp_pg=0 (spawn #146842) 2025-05-04 08:34:25.656324 :927F3BB6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:34:25.656324 :927F3BB7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=233 time=3618442828 2025-05-04 08:34:25.656324 :927F3BB8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:34:25.656325 :927F3BB9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:34:25.656325 :927F3BBA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:34:25.656325 :927F3BBB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:34:25.656326 :927F3BBC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:34:25.656821 :927F3BBD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:34:25.656867 :927F3BC5:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 08:44:26.488334 :9280047F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 08:44:26.911597 :928004E8:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 08:44:26.906 2025-05-04 08:44:26.911599 :928004E9:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9636 pso_num=25 pso_serial#=97 2025-05-04 08:44:26.911745 :928004EA:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9636 osp_idx=23 osp_ver=74556 osp_pg=0 (spawn #146864) 2025-05-04 08:44:26.911746 :928004EB:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:44:26.911747 :928004EC:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=234 time=3619044078 2025-05-04 08:44:26.911747 :928004ED:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:44:26.911747 :928004EE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:44:26.911748 :928004EF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:44:26.911748 :928004F0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:44:26.911748 :928004F1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:44:26.912245 :928004F2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:44:26.912289 :928004F9:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 08:54:27.836449 :9280C9C5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 08:54:28.060887 :9280CA20:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 08:54:28.056 2025-05-04 08:54:28.060888 :9280CA21:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11620 pso_num=25 pso_serial#=98 2025-05-04 08:54:28.061024 :9280CA22:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11620 osp_idx=23 osp_ver=74557 osp_pg=0 (spawn #146887) 2025-05-04 08:54:28.061024 :9280CA23:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 08:54:28.061025 :9280CA24:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=235 time=3619645234 2025-05-04 08:54:28.061025 :9280CA25:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 08:54:28.061026 :9280CA26:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 08:54:28.061026 :9280CA27:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 08:54:28.061026 :9280CA28:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 08:54:28.061026 :9280CA29:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 08:54:28.061523 :9280CA2A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 08:54:28.061572 :9280CA32:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 08:55:21.919290 :9280DB4F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=16 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-04 09:04:29.383608 :928199C1:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksl2.h LINE:2165 ID:kslpsr' id1=255 id2=0 name=EV type=0 fac#=0 facpost=1 2025-05-04 09:14:30.416671 :9282697F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 09:14:30.686277 :928269D9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 09:14:30.682 2025-05-04 09:14:30.686279 :928269DA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11020 pso_num=25 pso_serial#=99 2025-05-04 09:14:30.686411 :928269DB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11020 osp_idx=23 osp_ver=74558 osp_pg=0 (spawn #146934) 2025-05-04 09:14:30.686412 :928269DC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 09:14:30.686412 :928269DD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=236 time=3620847859 2025-05-04 09:14:30.686413 :928269DE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 09:14:30.686413 :928269DF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 09:14:30.686414 :928269E0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 09:14:30.686414 :928269E1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 09:14:30.686414 :928269E2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 09:14:30.686966 :928269E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 09:14:30.687010 :928269EC:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 09:24:31.652280 :92832FBA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 09:24:31.969282 :92833014:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 09:24:31.964 2025-05-04 09:24:31.969285 :92833015:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11904 pso_num=25 pso_serial#=100 2025-05-04 09:24:31.969425 :92833016:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11904 osp_idx=23 osp_ver=74559 osp_pg=0 (spawn #146959) 2025-05-04 09:24:31.969426 :92833017:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 09:24:31.969426 :92833018:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=237 time=3621449140 2025-05-04 09:24:31.969426 :92833019:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 09:24:31.969427 :9283301A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 09:24:31.969427 :9283301B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 09:24:31.969427 :9283301C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 09:24:31.969427 :9283301D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 09:24:31.969931 :9283301E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 09:24:31.969977 :92833028:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 09:34:32.892143 :9283F61C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 09:34:33.209532 :9283F680:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 09:34:33.205 2025-05-04 09:34:33.209534 :9283F681:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9800 pso_num=25 pso_serial#=101 2025-05-04 09:34:33.209661 :9283F682:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9800 osp_idx=23 osp_ver=74560 osp_pg=0 (spawn #146982) 2025-05-04 09:34:33.209662 :9283F683:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 09:34:33.209663 :9283F684:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=238 time=3622050375 2025-05-04 09:34:33.209663 :9283F685:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 09:34:33.209663 :9283F686:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 09:34:33.209664 :9283F687:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 09:34:33.209664 :9283F688:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 09:34:33.209664 :9283F689:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 09:34:33.210236 :9283F68A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 09:34:33.210281 :9283F693:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 09:44:34.045818 :9284BB92:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 09:44:34.472233 :9284BBF4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 09:44:34.467 2025-05-04 09:44:34.472234 :9284BBF5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11572 pso_num=25 pso_serial#=102 2025-05-04 09:44:34.472371 :9284BBF6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11572 osp_idx=23 osp_ver=74561 osp_pg=0 (spawn #147004) 2025-05-04 09:44:34.472372 :9284BBF7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 09:44:34.472372 :9284BBF8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=239 time=3622651640 2025-05-04 09:44:34.472372 :9284BBF9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 09:44:34.472373 :9284BBFA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 09:44:34.472373 :9284BBFB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 09:44:34.472373 :9284BBFC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 09:44:34.472374 :9284BBFD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 09:44:34.472853 :9284BBFE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 09:44:34.472898 :9284BC05:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=23 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-05-04 09:54:35.356728 :92858144:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-05-04 09:54:35.845513 :928581AF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 05-04 09:54:35.841 2025-05-04 09:54:35.845515 :928581B0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10608 pso_num=25 pso_serial#=103 2025-05-04 09:54:35.845649 :928581B1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10608 osp_idx=23 osp_ver=74562 osp_pg=0 (spawn #147027) 2025-05-04 09:54:35.845650 :928581B2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-05-04 09:54:35.845650 :928581B3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=240 time=3623253015 2025-05-04 09:54:35.845650 :928581B4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-05-04 09:54:35.845651 :928581B5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-05-04 09:54:35.845651 :928581B6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-05-04 09:54:35.845652 :928581B7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-05-04 09:54:35.845652 :928581B8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-05-04 09:54:35.846127 :928581B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=23 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-05-04 09:54:35.846175 :928581C0: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: 10608, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de