Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250713140332\orcl_w000_8216_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250713140332\orcl_w000_8216_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:36351M/63366M, Ph+PgF:42375M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 8216, image: ORACLE.EXE (W000) *** 2025-07-13 14:03:32.148 *** SESSION ID:(201.39839) 2025-07-13 14:03:32.148 *** 2025-07-13 14:03:32.148 Process diagnostic dump for ORACLE.EXE (W000), OS id=8216, pid: 25, proc_ser: 15, sid: 201, sess_ser: 39839 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=34 seq_num=35 snap_id=1 wait times: snap=2.608777 sec, exc=2.608777 sec, total=2.608777 sec wait times: max=5.000000 sec, heur=2 min 47 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=33 seq_num=34 snap_id=1 wait times: snap=5.014777 sec, exc=5.014777 sec, total=5.014777 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=32 seq_num=33 snap_id=1 wait times: snap=5.007238 sec, exc=5.007238 sec, total=5.007238 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000028 sec of elapsed time 2: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=31 seq_num=32 snap_id=1 wait times: snap=5.001426 sec, exc=5.001426 sec, total=5.001426 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 3: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=30 seq_num=31 snap_id=1 wait times: snap=5.010980 sec, exc=5.010980 sec, total=5.010980 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 4: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=29 seq_num=30 snap_id=1 wait times: snap=5.007514 sec, exc=5.007514 sec, total=5.007514 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=28 seq_num=29 snap_id=1 wait times: snap=5.004651 sec, exc=5.004651 sec, total=5.004651 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 6: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=27 seq_num=28 snap_id=1 wait times: snap=5.015242 sec, exc=5.015242 sec, total=5.015242 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 7: 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.003219 sec, exc=5.003219 sec, total=5.003219 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 8: 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.000557 sec, exc=5.000557 sec, total=5.000557 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=24 seq_num=25 snap_id=1 wait times: snap=5.000257 sec, exc=5.000257 sec, total=5.000257 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000026 sec of elapsed time Sampled Session History of session 201 serial 39839 --------------------------------------------------- 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:01:32 - 14:03:32] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-13 14:03:32.148 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 8216, W000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-13 11:40:25.689955 :B16A81ED:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 11:40:25.689956 :B16A81EE:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 11:40:25.689956 :B16A81EF:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 11:40:25.689956 :B16A81F0:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 11:40:25.689956 :B16A81F1:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 11:40:25.690460 :B16A81F2: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-07-13 11:40:25.690509 :B16A81FC: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-07-13 11:40:55.741646 :B16A8BC4:db_trace:ksl2.c@2477:kslwtbctx(): [10005:25:201] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=7 seq_num=8 snap_id=1 2025-07-13 11:40:55.741663 :B16A8BCD:db_trace:ksl2.c@2611:kslwtectx(): [10005:25:201] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=7 seq_num=8 snap_id=1 2025-07-13 11:40:55.741665 :B16A8BCE:db_trace:ksl2.c@2619:kslwtectx(): [10005:25:201] KSL WAIT END wait times (usecs) - snap=17, exc=17, tot=17 2025-07-13 11:41:10.759017 :B16A9072:db_trace:ksl2.c@2477:kslwtbctx(): [10005:25:201] KSL WAIT BEG [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=11 seq_num=12 snap_id=1 2025-07-13 11:41:10.759024 :B16A9076:db_trace:ksl2.c@2611:kslwtectx(): [10005:25:201] KSL WAIT END [latch free] 136537728/0x8236680 259/0x103 0/0x0 wait_id=11 seq_num=12 snap_id=1 2025-07-13 11:41:10.759025 :B16A9078:db_trace:ksl2.c@2619:kslwtectx(): [10005:25:201] KSL WAIT END wait times (usecs) - snap=8, exc=8, tot=8 2025-07-13 11:41:10.759033 :B16A9088: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-07-13 11:50:26.550339 :B16B4522:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 11:50:27.065376 :B16B458B:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 11:50:27.060 2025-07-13 11:50:27.065378 :B16B458C:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4152 pso_num=25 pso_serial#=3 2025-07-13 11:50:27.065518 :B16B458D:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4152 osp_idx=23 osp_ver=195700 osp_pg=0 (spawn #381083) 2025-07-13 11:50:27.065519 :B16B458E:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 11:50:27.065520 :B16B458F:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=246 time=1088202954 2025-07-13 11:50:27.065520 :B16B4590:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 11:50:27.065520 :B16B4591:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 11:50:27.065521 :B16B4592:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 11:50:27.065521 :B16B4593:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 11:50:27.065521 :B16B4594:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 11:50:27.066024 :B16B4595: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-07-13 11:50:27.066073 :B16B459C: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-07-13 12:00:27.976740 :B16C093F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 12:00:28.434884 :B16C09A1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 12:00:28.429 2025-07-13 12:00:28.434887 :B16C09A2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4124 pso_num=25 pso_serial#=4 2025-07-13 12:00:28.435029 :B16C09A3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=4124 osp_idx=23 osp_ver=195701 osp_pg=0 (spawn #381106) 2025-07-13 12:00:28.435030 :B16C09A4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 12:00:28.435031 :B16C09A5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=247 time=1088804329 2025-07-13 12:00:28.435031 :B16C09A6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 12:00:28.435032 :B16C09A7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 12:00:28.435032 :B16C09A8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 12:00:28.435032 :B16C09A9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 12:00:28.435033 :B16C09AA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 12:00:28.435563 :B16C09AB: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-07-13 12:00:28.435605 :B16C09B2: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-07-13 12:10:29.387206 :B16CD5CF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 12:10:29.870959 :B16CD624:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 12:10:29.866 2025-07-13 12:10:29.870962 :B16CD625:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13572 pso_num=25 pso_serial#=5 2025-07-13 12:10:29.871099 :B16CD626:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13572 osp_idx=23 osp_ver=195702 osp_pg=0 (spawn #381131) 2025-07-13 12:10:29.871100 :B16CD627:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 12:10:29.871101 :B16CD628:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=248 time=1089405767 2025-07-13 12:10:29.871101 :B16CD629:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 12:10:29.871102 :B16CD62A:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 12:10:29.871102 :B16CD62B:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 12:10:29.871102 :B16CD62C:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 12:10:29.871103 :B16CD62D:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 12:10:29.871624 :B16CD62E: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-07-13 12:10:29.871690 :B16CD636: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-07-13 12:20:30.763307 :B16D9C4F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 12:20:31.236973 :B16D9CB9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 12:20:31.232 2025-07-13 12:20:31.236975 :B16D9CBA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18388 pso_num=25 pso_serial#=6 2025-07-13 12:20:31.237118 :B16D9CBB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18388 osp_idx=23 osp_ver=195703 osp_pg=0 (spawn #381154) 2025-07-13 12:20:31.237119 :B16D9CBC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 12:20:31.237119 :B16D9CBD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=249 time=1090007126 2025-07-13 12:20:31.237119 :B16D9CBE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 12:20:31.237120 :B16D9CBF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 12:20:31.237120 :B16D9CC0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 12:20:31.237120 :B16D9CC1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 12:20:31.237121 :B16D9CC2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 12:20:31.237621 :B16D9CC3: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-07-13 12:20:31.237671 :B16D9CCB: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-07-13 12:25:22.098102 :B16DFB04: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-07-13 12:30:32.606679 :B16E6184: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-07-13 12:31:17.659386 :B16E6FED: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-07-13 12:40:33.553676 :B16F2571:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 12:40:33.902045 :B16F25CF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 12:40:33.897 2025-07-13 12:40:33.902046 :B16F25D0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12720 pso_num=25 pso_serial#=7 2025-07-13 12:40:33.902184 :B16F25D1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12720 osp_idx=23 osp_ver=195704 osp_pg=0 (spawn #381198) 2025-07-13 12:40:33.902184 :B16F25D2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 12:40:33.902185 :B16F25D3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=250 time=1091209798 2025-07-13 12:40:33.902185 :B16F25D4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 12:40:33.902186 :B16F25D5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 12:40:33.902186 :B16F25D6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 12:40:33.902186 :B16F25D7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 12:40:33.902187 :B16F25D8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 12:40:33.902699 :B16F25D9: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-07-13 12:40:33.902745 :B16F25E2: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-07-13 12:50:34.742364 :B16FE9DA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 12:50:35.137741 :B16FEA42:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 12:50:35.133 2025-07-13 12:50:35.137743 :B16FEA43:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10520 pso_num=25 pso_serial#=8 2025-07-13 12:50:35.137892 :B16FEA44:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10520 osp_idx=23 osp_ver=195705 osp_pg=0 (spawn #381221) 2025-07-13 12:50:35.137894 :B16FEA45:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 12:50:35.137895 :B16FEA46:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=251 time=1091811033 2025-07-13 12:50:35.137895 :B16FEA47:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 12:50:35.137895 :B16FEA48:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 12:50:35.137896 :B16FEA49:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 12:50:35.137896 :B16FEA4A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 12:50:35.137896 :B16FEA4B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 12:50:35.138400 :B16FEA4C: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-07-13 12:50:35.138463 :B16FEA52: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-07-13 13:00:36.029313 :B170B019:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 13:00:36.330997 :B170B078:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 13:00:36.326 2025-07-13 13:00:36.330999 :B170B079:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9092 pso_num=25 pso_serial#=9 2025-07-13 13:00:36.331133 :B170B07A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9092 osp_idx=23 osp_ver=195706 osp_pg=0 (spawn #381245) 2025-07-13 13:00:36.331133 :B170B07B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 13:00:36.331134 :B170B07C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=252 time=1092412220 2025-07-13 13:00:36.331134 :B170B07D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 13:00:36.331134 :B170B07E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 13:00:36.331135 :B170B07F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 13:00:36.331135 :B170B080:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 13:00:36.331135 :B170B081:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 13:00:36.331620 :B170B082: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-07-13 13:00:36.331666 :B170B089: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-07-13 13:10:37.264081 :B1717FEB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 13:10:37.596978 :B1718047:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 13:10:37.592 2025-07-13 13:10:37.596980 :B1718048:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8692 pso_num=25 pso_serial#=10 2025-07-13 13:10:37.597118 :B1718049:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8692 osp_idx=23 osp_ver=195707 osp_pg=0 (spawn #381270) 2025-07-13 13:10:37.597119 :B171804A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 13:10:37.597119 :B171804B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=253 time=1093013486 2025-07-13 13:10:37.597120 :B171804C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 13:10:37.597120 :B171804D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 13:10:37.597120 :B171804E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 13:10:37.597121 :B171804F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 13:10:37.597121 :B1718050:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 13:10:37.597612 :B1718051: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-07-13 13:10:37.597655 :B1718057: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-07-13 13:20:38.528466 :B172445A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 13:20:38.894311 :B17244C1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 13:20:38.890 2025-07-13 13:20:38.894314 :B17244C2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=13528 pso_num=25 pso_serial#=11 2025-07-13 13:20:38.894509 :B17244C3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=13528 osp_idx=23 osp_ver=195708 osp_pg=0 (spawn #381293) 2025-07-13 13:20:38.894509 :B17244C4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 13:20:38.894510 :B17244C5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=254 time=1093614783 2025-07-13 13:20:38.894510 :B17244C6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 13:20:38.894511 :B17244C7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 13:20:38.894511 :B17244C8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 13:20:38.894512 :B17244C9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 13:20:38.894512 :B17244CA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 13:20:38.895007 :B17244CB: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-07-13 13:20:38.895053 :B17244D2: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-07-13 13:30:39.778075 :B173096C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 13:30:40.189278 :B17309C6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 13:30:40.184 2025-07-13 13:30:40.189281 :B17309C7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17204 pso_num=25 pso_serial#=12 2025-07-13 13:30:40.189437 :B17309C8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17204 osp_idx=23 osp_ver=195709 osp_pg=0 (spawn #381316) 2025-07-13 13:30:40.189437 :B17309C9:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 13:30:40.189438 :B17309CA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=255 time=1094216079 2025-07-13 13:30:40.189438 :B17309CB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 13:30:40.189438 :B17309CC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 13:30:40.189439 :B17309CD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 13:30:40.189440 :B17309CE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 13:30:40.189440 :B17309CF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 13:30:40.189948 :B17309D0: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-07-13 13:30:40.189997 :B17309D9: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-07-13 13:40:41.164255 :B173CD15:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 13:40:41.528470 :B173CD80:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 13:40:41.523 2025-07-13 13:40:41.528472 :B173CD81:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=316 pso_num=25 pso_serial#=13 2025-07-13 13:40:41.528608 :B173CD82:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=316 osp_idx=23 osp_ver=195710 osp_pg=0 (spawn #381338) 2025-07-13 13:40:41.528608 :B173CD83:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 13:40:41.528609 :B173CD84:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=0 time=1094817423 2025-07-13 13:40:41.528609 :B173CD85:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 13:40:41.528610 :B173CD86:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 13:40:41.528610 :B173CD87:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 13:40:41.528610 :B173CD88:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 13:40:41.528611 :B173CD89:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 13:40:41.529107 :B173CD8A: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-07-13 13:40:41.529158 :B173CD90: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-07-13 13:50:42.502277 :B1749219:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 13:50:42.928943 :B1749272:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 13:50:42.924 2025-07-13 13:50:42.928945 :B1749273:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17996 pso_num=25 pso_serial#=14 2025-07-13 13:50:42.929079 :B1749274:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17996 osp_idx=23 osp_ver=195711 osp_pg=0 (spawn #381361) 2025-07-13 13:50:42.929080 :B1749275:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 13:50:42.929080 :B1749276:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=1 time=1095418829 2025-07-13 13:50:42.929080 :B1749277:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 13:50:42.929081 :B1749278:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 13:50:42.929081 :B1749279:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 13:50:42.929081 :B174927A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 13:50:42.929082 :B174927B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 13:50:42.929573 :B174927C: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-07-13 13:50:42.929626 :B1749284: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-07-13 14:00:43.935853 :B1755879:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-13 14:00:44.300011 :B17558CF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-13 14:00:44.295 2025-07-13 14:00:44.300013 :B17558D0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8216 pso_num=25 pso_serial#=15 2025-07-13 14:00:44.300158 :B17558D1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8216 osp_idx=23 osp_ver=195712 osp_pg=0 (spawn #381386) 2025-07-13 14:00:44.300159 :B17558D2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-13 14:00:44.300159 :B17558D3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=2 time=1096020189 2025-07-13 14:00:44.300160 :B17558D4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-13 14:00:44.300160 :B17558D5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-13 14:00:44.300160 :B17558D6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-13 14:00:44.300161 :B17558D7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-13 14:00:44.300161 :B17558D8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-13 14:00:44.300686 :B17558D9: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-07-13 14:00:44.300745 :B17558E3: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: 8216, W000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de