Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427221041\orcl_w000_10608_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250427221041\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:37586M/63366M, Ph+PgF:45283M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 10608, image: ORACLE.EXE (W000) *** 2025-04-27 22:10:41.593 *** SESSION ID:(201.17771) 2025-04-27 22:10:41.593 *** 2025-04-27 22:10:41.593 Process diagnostic dump for ORACLE.EXE (W000), OS id=10608, pid: 25, proc_ser: 165, sid: 201, sess_ser: 17771 ------------------------------------------------------------------------------- current sql: <none> Current Wait Stack: 0: waiting for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=76 seq_num=77 snap_id=1 wait times: snap=1.176868 sec, exc=1.176868 sec, total=1.176868 sec wait times: max=5.000000 sec, heur=5 min 31 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.000022 sec since current wait 0: 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.001255 sec, exc=5.001255 sec, total=5.001255 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000018 sec of elapsed time 1: 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.007317 sec, exc=5.007317 sec, total=5.007317 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 2: 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.003786 sec, exc=5.003786 sec, total=5.003786 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000021 sec of elapsed time 3: 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.014710 sec, exc=5.014710 sec, total=5.014710 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 4: 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.004611 sec, exc=5.004611 sec, total=5.004611 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000024 sec of elapsed time 5: 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.014707 sec, exc=5.014707 sec, total=5.014707 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000029 sec of elapsed time 6: 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.015220 sec, exc=5.015220 sec, total=5.015220 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000035 sec of elapsed time 7: 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.003666 sec, exc=5.003666 sec, total=5.003666 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000038 sec of elapsed time 8: waited for 'Space Manager: slave idle wait' Slave ID=0x0, =0x0, =0x0 wait_id=67 seq_num=68 snap_id=1 wait times: snap=5.006949 sec, exc=5.006949 sec, total=5.006949 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=66 seq_num=67 snap_id=1 wait times: snap=5.014673 sec, exc=5.014673 sec, total=5.014673 sec wait times: max=5.000000 sec wait counts: calls=1 os=1 occurred after 0.000087 sec of elapsed time Sampled Session History of session 201 serial 17771 --------------------------------------------------- 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, 22:08:41 - 22:10:41] idle wait at each sample ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-04-27 22:10:41.593 ------------------------------------------------------------------------------- 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-04-27 19:44:14.562686 :8F984E0B: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-04-27 19:44:14.562741 :8F984E15: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-04-27 19:54:15.405487 :8F9919BA:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 19:54:15.691407 :8F9919DD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 19:54:15.687 2025-04-27 19:54:15.691409 :8F9919DE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11036 pso_num=25 pso_serial#=151 2025-04-27 19:54:15.691553 :8F9919DF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11036 osp_idx=23 osp_ver=66450 osp_pg=0 (spawn #124707) 2025-04-27 19:54:15.691554 :8F9919E0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 19:54:15.691554 :8F9919E1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=197 time=3054445171 2025-04-27 19:54:15.691555 :8F9919E2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 19:54:15.691555 :8F9919E3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 19:54:15.691556 :8F9919E4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 19:54:15.691556 :8F9919E5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 19:54:15.691557 :8F9919E6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 19:54:15.692048 :8F9919E7: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-04-27 19:54:15.692093 :8F9919EF: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-04-27 20:00:09.448897 :8F99935B: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-04-27 20:04:16.946780 :8F99E95D: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-04-27 20:14:17.815469 :8F9ABC19:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 20:14:18.241921 :8F9ABC3C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 20:14:18.237 2025-04-27 20:14:18.241924 :8F9ABC3D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10084 pso_num=25 pso_serial#=152 2025-04-27 20:14:18.242062 :8F9ABC3E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10084 osp_idx=23 osp_ver=66451 osp_pg=0 (spawn #124757) 2025-04-27 20:14:18.242062 :8F9ABC3F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 20:14:18.242063 :8F9ABC40:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=198 time=3055647718 2025-04-27 20:14:18.242063 :8F9ABC41:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 20:14:18.242064 :8F9ABC42:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 20:14:18.242064 :8F9ABC43:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 20:14:18.242064 :8F9ABC44:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 20:14:18.242064 :8F9ABC45:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 20:14:18.242550 :8F9ABC46: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-04-27 20:14:18.242598 :8F9ABC4F: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-04-27 20:24:19.067309 :8F9B8BA6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 20:24:19.603276 :8F9B8BE3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 20:24:19.598 2025-04-27 20:24:19.603278 :8F9B8BE4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9012 pso_num=25 pso_serial#=153 2025-04-27 20:24:19.603407 :8F9B8BE5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9012 osp_idx=23 osp_ver=66452 osp_pg=0 (spawn #124779) 2025-04-27 20:24:19.603408 :8F9B8BE6:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 20:24:19.603408 :8F9B8BE7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=199 time=3056249078 2025-04-27 20:24:19.603409 :8F9B8BE8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 20:24:19.603409 :8F9B8BE9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 20:24:19.603409 :8F9B8BEA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 20:24:19.603410 :8F9B8BEB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 20:24:19.603410 :8F9B8BEC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 20:24:19.603946 :8F9B8BED: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-04-27 20:24:19.603991 :8F9B8BF3: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-04-27 20:34:20.428080 :8F9C57FB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 20:34:20.989832 :8F9C581F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 20:34:20.984 2025-04-27 20:34:20.989834 :8F9C5820:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10876 pso_num=25 pso_serial#=154 2025-04-27 20:34:20.989968 :8F9C5821:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10876 osp_idx=23 osp_ver=66453 osp_pg=0 (spawn #124802) 2025-04-27 20:34:20.989970 :8F9C5822:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 20:34:20.989971 :8F9C5823:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=200 time=3056850468 2025-04-27 20:34:20.989971 :8F9C5824:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 20:34:20.989971 :8F9C5825:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 20:34:20.989971 :8F9C5826:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 20:34:20.989972 :8F9C5827:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 20:34:20.989972 :8F9C5828:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 20:34:20.990459 :8F9C5829: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-04-27 20:34:20.990505 :8F9C5831: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-04-27 20:44:21.845953 :8F9D2439:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 20:44:22.225539 :8F9D245E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 20:44:22.221 2025-04-27 20:44:22.225541 :8F9D245F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=9000 pso_num=25 pso_serial#=155 2025-04-27 20:44:22.225681 :8F9D2460:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=9000 osp_idx=23 osp_ver=66454 osp_pg=0 (spawn #124825) 2025-04-27 20:44:22.225681 :8F9D2461:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 20:44:22.225682 :8F9D2462:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=201 time=3057451703 2025-04-27 20:44:22.225682 :8F9D2463:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 20:44:22.225683 :8F9D2464:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 20:44:22.225683 :8F9D2465:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 20:44:22.225684 :8F9D2466:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 20:44:22.225684 :8F9D2467:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 20:44:22.226188 :8F9D2468: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-04-27 20:44:22.226236 :8F9D246F: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-04-27 20:54:23.091213 :8F9DF07A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 20:54:23.627234 :8F9DF0A9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 20:54:23.622 2025-04-27 20:54:23.627236 :8F9DF0AA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10204 pso_num=25 pso_serial#=156 2025-04-27 20:54:23.627374 :8F9DF0AB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10204 osp_idx=23 osp_ver=66455 osp_pg=0 (spawn #124847) 2025-04-27 20:54:23.627375 :8F9DF0AC:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 20:54:23.627375 :8F9DF0AD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=202 time=3058053109 2025-04-27 20:54:23.627376 :8F9DF0AE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 20:54:23.627376 :8F9DF0AF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 20:54:23.627376 :8F9DF0B0:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 20:54:23.627377 :8F9DF0B1:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 20:54:23.627377 :8F9DF0B2:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 20:54:23.627881 :8F9DF0B3: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-04-27 20:54:23.627927 :8F9DF0B9: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-04-27 21:04:24.477087 :8F9EBF80:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:04:24.584276 :8F9EBF83:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:04:24.571 2025-04-27 21:04:24.584278 :8F9EBF84:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=4572 pso_num=25 pso_serial#=157 2025-04-27 21:04:24.584419 :8F9EBF85:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=4572 (legacy spawn) 2025-04-27 21:04:24.590922 :8F9EBF86:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 21:04:24.591087 :8F9EBF8B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-04-27 21:04:24.591891 :8F9EBF90:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:04:24.600511 :8F9EBF93:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:04:24.586 2025-04-27 21:04:24.600513 :8F9EBF94:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10608 pso_num=25 pso_serial#=158 2025-04-27 21:04:24.600647 :8F9EBF95:db_trace:kso.c@4070:ksonfy(): [10420:25:0] kso: new process: pid=10608 (legacy spawn) 2025-04-27 21:04:24.607127 :8F9EBF96:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-04-27 21:04:24.607289 :8F9EBF9F:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-04-27 21:04:24.608121 :8F9EBFA0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:04:24.913778 :8F9EBFC5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:04:24.909 2025-04-27 21:04:24.913780 :8F9EBFC6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10164 pso_num=25 pso_serial#=159 2025-04-27 21:04:24.913951 :8F9EBFC7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10164 osp_idx=23 osp_ver=66458 osp_pg=0 (spawn #124873) 2025-04-27 21:04:24.913952 :8F9EBFC8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 21:04:24.913952 :8F9EBFC9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=203 time=3058654390 2025-04-27 21:04:24.913952 :8F9EBFCA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 21:04:24.913952 :8F9EBFCB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 21:04:24.913953 :8F9EBFCC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 21:04:24.913953 :8F9EBFCD:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 21:04:24.913954 :8F9EBFCE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 21:04:24.914453 :8F9EBFCF: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-04-27 21:04:24.914498 :8F9EBFD7: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-04-27 21:14:25.734806 :8F9F94F9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:14:26.255150 :8F9F951E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:14:26.250 2025-04-27 21:14:26.255152 :8F9F951F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10664 pso_num=25 pso_serial#=160 2025-04-27 21:14:26.255289 :8F9F9520:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10664 osp_idx=23 osp_ver=66459 osp_pg=0 (spawn #124898) 2025-04-27 21:14:26.255290 :8F9F9521:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 21:14:26.255290 :8F9F9522:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=204 time=3059255734 2025-04-27 21:14:26.255290 :8F9F9523:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 21:14:26.255291 :8F9F9524:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 21:14:26.255291 :8F9F9525:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 21:14:26.255291 :8F9F9526:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 21:14:26.255291 :8F9F9527:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 21:14:26.255825 :8F9F9528: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-04-27 21:14:26.255877 :8F9F9530: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-04-27 21:24:27.101443 :8FA0611C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:24:27.528051 :8FA0614D:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:24:27.523 2025-04-27 21:24:27.528053 :8FA0614E:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11116 pso_num=25 pso_serial#=161 2025-04-27 21:24:27.528193 :8FA0614F:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11116 osp_idx=23 osp_ver=66460 osp_pg=0 (spawn #124920) 2025-04-27 21:24:27.528193 :8FA06150:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 21:24:27.528194 :8FA06151:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=205 time=3059857015 2025-04-27 21:24:27.528194 :8FA06152:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 21:24:27.528195 :8FA06153:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 21:24:27.528195 :8FA06154:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 21:24:27.528196 :8FA06155:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 21:24:27.528196 :8FA06156:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 21:24:27.528684 :8FA06157: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-04-27 21:24:27.528734 :8FA0615D: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-04-27 21:34:28.470999 :8FA12DBB:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:34:28.913189 :8FA12DDE:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:34:28.908 2025-04-27 21:34:28.913191 :8FA12DDF:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8312 pso_num=25 pso_serial#=162 2025-04-27 21:34:28.913324 :8FA12DE0:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8312 osp_idx=23 osp_ver=66461 osp_pg=0 (spawn #124943) 2025-04-27 21:34:28.913325 :8FA12DE1:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 21:34:28.913325 :8FA12DE2:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=206 time=3060458390 2025-04-27 21:34:28.913325 :8FA12DE3:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 21:34:28.913326 :8FA12DE4:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 21:34:28.913326 :8FA12DE5:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 21:34:28.913326 :8FA12DE6:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 21:34:28.913327 :8FA12DE7:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 21:34:28.913806 :8FA12DE8: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-04-27 21:34:28.913847 :8FA12DEF: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-04-27 21:44:29.767193 :8FA1FA59:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:44:30.146886 :8FA1FA88:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:44:30.142 2025-04-27 21:44:30.146888 :8FA1FA89:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3752 pso_num=25 pso_serial#=163 2025-04-27 21:44:30.147019 :8FA1FA8A:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3752 osp_idx=23 osp_ver=66462 osp_pg=0 (spawn #124966) 2025-04-27 21:44:30.147020 :8FA1FA8B:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 21:44:30.147020 :8FA1FA8C:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=207 time=3061059625 2025-04-27 21:44:30.147020 :8FA1FA8D:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 21:44:30.147021 :8FA1FA8E:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 21:44:30.147021 :8FA1FA8F:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 21:44:30.147022 :8FA1FA90:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 21:44:30.147022 :8FA1FA91:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 21:44:30.147516 :8FA1FA92: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-04-27 21:44:30.147562 :8FA1FA99: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-04-27 21:54:31.003310 :8FA2C6B5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 21:54:31.351634 :8FA2C700:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 21:54:31.347 2025-04-27 21:54:31.351636 :8FA2C701:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=8072 pso_num=25 pso_serial#=164 2025-04-27 21:54:31.351773 :8FA2C702:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=8072 osp_idx=23 osp_ver=66463 osp_pg=0 (spawn #124988) 2025-04-27 21:54:31.351774 :8FA2C703:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 21:54:31.351774 :8FA2C704:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=208 time=3061660828 2025-04-27 21:54:31.351774 :8FA2C705:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 21:54:31.351775 :8FA2C706:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 21:54:31.351775 :8FA2C707:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 21:54:31.351776 :8FA2C708:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 21:54:31.351776 :8FA2C709:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 21:54:31.352264 :8FA2C70A: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-04-27 21:54:31.352309 :8FA2C714: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-04-27 22:04:32.276439 :8FA395E9:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-04-27 22:04:32.562386 :8FA39643:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 04-27 22:04:32.557 2025-04-27 22:04:32.562388 :8FA39644:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10608 pso_num=25 pso_serial#=165 2025-04-27 22:04:32.562522 :8FA39645:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10608 osp_idx=23 osp_ver=66464 osp_pg=0 (spawn #125014) 2025-04-27 22:04:32.562523 :8FA39646:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=1236 spawner_pid=3660 sga_crt_ts=x8A8A 2025-04-27 22:04:32.562523 :8FA39647:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=209 time=3062262046 2025-04-27 22:04:32.562524 :8FA39648:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-04-27 22:04:32.562524 :8FA39649:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-04-27 22:04:32.562524 :8FA3964A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-04-27 22:04:32.562525 :8FA3964B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-04-27 22:04:32.562525 :8FA3964C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-04-27 22:04:32.563027 :8FA3964D: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-04-27 22:04:32.563078 :8FA39655: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-04-27 22:05:09.954425 :8FA3A4AE: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 ------------------------------------------------------------------------------- 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