Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250601100644\orcl_j001_14596_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250601100644\orcl_j001_14596_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:37194M/63366M, Ph+PgF:44086M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 14596, image: ORACLE.EXE (J001) *** 2025-06-01 10:06:44.152 *** SESSION ID:(209.15265) 2025-06-01 10:06:44.152 *** 2025-06-01 10:06:44.152 Process diagnostic dump for ORACLE.EXE (J001), OS id=14596, pid: 26, proc_ser: 54, sid: 209, sess_ser: 15265 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 14596 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.386923 sec, exc=0.386923 sec, total=0.386923 sec wait times: max=0.500000 sec, heur=4.389519 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.000010 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500003 sec, exc=0.500003 sec, total=0.500003 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.505089 sec, exc=0.505089 sec, total=0.505089 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.500002 sec, exc=0.500002 sec, total=0.500002 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000010 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499993 sec, exc=0.499993 sec, total=0.499993 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.499989 sec, exc=0.499989 sec, total=0.499989 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000015 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.497439 sec, exc=0.497439 sec, total=0.497439 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000000 sec of elapsed time Sampled Session History of session 209 serial 15265 --------------------------------------------------- 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 --------------------------------------------------- [5 samples, 10:06:39 - 10:06:44] idle wait at each sample [session created at: 10:06:39] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-01 10:06:44.152 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 14596, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-01 09:58:51.295713 :9ED374DA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 09:59:21.356421 :9ED37E9C:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 09:59:51.395201 :9ED3885B:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 09:59:51.384 2025-06-01 09:59:51.395203 :9ED3885C:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9092 pso_num=26 pso_serial#=46 2025-06-01 09:59:51.395336 :9ED3885D:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=9092 osp_idx=24 osp_ver=366736 osp_pg=0 (spawn #240825) 2025-06-01 09:59:51.395336 :9ED3885E:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 09:59:51.395337 :9ED3885F:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=135 time=1747750032 2025-06-01 09:59:51.395337 :9ED38860:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 09:59:51.395337 :9ED38861:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 09:59:51.395337 :9ED38862:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 09:59:51.395338 :9ED38863:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 09:59:51.395338 :9ED38864:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 09:59:51.395862 :9ED38865:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:00:21.463788 :9ED39299:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:00:26.466596 :9ED3947A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:00:26.455 2025-06-01 10:00:26.466598 :9ED3947B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=10896 pso_num=26 pso_serial#=47 2025-06-01 10:00:26.466741 :9ED3947C:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=10896 osp_idx=24 osp_ver=366737 osp_pg=0 (spawn #240827) 2025-06-01 10:00:26.466742 :9ED3947D:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:00:26.466742 :9ED3947E:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=136 time=1747785110 2025-06-01 10:00:26.466742 :9ED3947F:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:00:26.466743 :9ED39480:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:00:26.466744 :9ED39481:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:00:26.466744 :9ED39482:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:00:26.466745 :9ED39483:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:00:26.467260 :9ED39484:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:00:51.505040 :9ED39DD6:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 10:01:21.620158 :9ED3A800:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:01:51.595796 :9ED3B1CE:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:01:51.584 2025-06-01 10:01:51.595798 :9ED3B1CF:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=12700 pso_num=26 pso_serial#=48 2025-06-01 10:01:51.595933 :9ED3B1D0:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=12700 osp_idx=24 osp_ver=366738 osp_pg=0 (spawn #240832) 2025-06-01 10:01:51.595934 :9ED3B1D1:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:01:51.595934 :9ED3B1D2:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=137 time=1747870235 2025-06-01 10:01:51.595935 :9ED3B1D3:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:01:51.595935 :9ED3B1D4:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:01:51.595935 :9ED3B1D5:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:01:51.595936 :9ED3B1D6:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:01:51.595936 :9ED3B1D7:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:01:51.596476 :9ED3B1D8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:02:21.708311 :9ED3BC09:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:02:51.690348 :9ED3C5CD:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:02:51.679 2025-06-01 10:02:51.690350 :9ED3C5CE:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14556 pso_num=26 pso_serial#=49 2025-06-01 10:02:51.690487 :9ED3C5CF:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14556 osp_idx=24 osp_ver=366739 osp_pg=0 (spawn #240834) 2025-06-01 10:02:51.690487 :9ED3C5D0:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:02:51.690488 :9ED3C5D1:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=138 time=1747930329 2025-06-01 10:02:51.690488 :9ED3C5D2:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:02:51.690488 :9ED3C5D3:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:02:51.690489 :9ED3C5D4:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:02:51.690489 :9ED3C5D5:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:02:51.690489 :9ED3C5D6:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:02:51.690976 :9ED3C5D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:03:21.798069 :9ED3CF80:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:03:51.773977 :9ED3D970:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:03:51.762 2025-06-01 10:03:51.773978 :9ED3D971:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13808 pso_num=26 pso_serial#=50 2025-06-01 10:03:51.774107 :9ED3D972:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13808 osp_idx=24 osp_ver=366740 osp_pg=0 (spawn #240836) 2025-06-01 10:03:51.774108 :9ED3D973:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:03:51.774108 :9ED3D974:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=139 time=1747990407 2025-06-01 10:03:51.774109 :9ED3D975:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:03:51.774109 :9ED3D976:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:03:51.774109 :9ED3D977:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:03:51.774109 :9ED3D978:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:03:51.774110 :9ED3D979:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:03:51.774611 :9ED3D97A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:04:21.834677 :9ED3E30B:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:04:51.904167 :9ED3ECDC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:04:51.893 2025-06-01 10:04:51.904169 :9ED3ECDD:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=13880 pso_num=26 pso_serial#=51 2025-06-01 10:04:51.904324 :9ED3ECDE:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=13880 osp_idx=24 osp_ver=366741 osp_pg=0 (spawn #240839) 2025-06-01 10:04:51.904325 :9ED3ECDF:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:04:51.904325 :9ED3ECE0:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=140 time=1748050547 2025-06-01 10:04:51.904325 :9ED3ECE1:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:04:51.904326 :9ED3ECE2:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:04:51.904326 :9ED3ECE3:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:04:51.904326 :9ED3ECE4:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:04:51.904327 :9ED3ECE5:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:04:51.904816 :9ED3ECE6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:05:21.978068 :9ED3F6A7:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:05:51.989128 :9ED40628:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:05:51.978 2025-06-01 10:05:51.989131 :9ED40629:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=9064 pso_num=26 pso_serial#=52 2025-06-01 10:05:51.989266 :9ED4062A:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=9064 osp_idx=24 osp_ver=366742 osp_pg=0 (spawn #240841) 2025-06-01 10:05:51.989267 :9ED4062B:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:05:51.989267 :9ED4062C:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=141 time=1748110625 2025-06-01 10:05:51.989267 :9ED4062D:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:05:51.989268 :9ED4062E:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:05:51.989268 :9ED4062F:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:05:51.989268 :9ED40630:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:05:51.989269 :9ED40631:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:05:51.989752 :9ED40632:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:06:22.099759 :9ED41104:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:06:37.922605 :9ED4163D:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:06:37.910 2025-06-01 10:06:37.922607 :9ED4163E:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14948 pso_num=26 pso_serial#=53 2025-06-01 10:06:37.922740 :9ED4163F:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14948 osp_idx=24 osp_ver=366743 osp_pg=0 (spawn #240843) 2025-06-01 10:06:37.922741 :9ED41640:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:06:37.922742 :9ED41641:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=142 time=1748156563 2025-06-01 10:06:37.922742 :9ED41642:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:06:37.922742 :9ED41643:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:06:37.922743 :9ED41644:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:06:37.922743 :9ED41645:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:06:37.922744 :9ED41646:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:06:37.923237 :9ED41647:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:06:37.923281 :9ED4164D:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 10:06:37.927452 :9ED41664:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-01 10:06:37.927502 :9ED41665:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-01 10:06:37.927751 :9ED41666:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-01 10:06:37.927769 :9ED41667:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-01 10:06:37.927983 :9ED41668:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-01 10:06:37.927997 :9ED41669:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-01 10:06:37.928223 :9ED4166A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-01 10:06:37.928246 :9ED4166B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-01 10:06:37.928524 :9ED4166C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-01 10:06:37.928538 :9ED4166D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-01 10:06:37.928746 :9ED4166E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:kelt.c:517 2025-06-01 10:06:37.928759 :9ED4166F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:kelt.c:517 2025-06-01 10:06:37.931113 :9ED416A2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-06-01 10:06:38.028151 :9ED417BC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 06-01 10:06:38.019 2025-06-01 10:06:38.028153 :9ED417BD:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=14596 pso_num=26 pso_serial#=54 2025-06-01 10:06:38.028291 :9ED417BE:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=14596 osp_idx=24 osp_ver=366744 osp_pg=0 (spawn #240846) 2025-06-01 10:06:38.028292 :9ED417BF:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-01 10:06:38.028292 :9ED417C0:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=143 time=1748156672 2025-06-01 10:06:38.028293 :9ED417C1:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-06-01 10:06:38.028293 :9ED417C2:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-06-01 10:06:38.028293 :9ED417C3:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-06-01 10:06:38.028294 :9ED417C4:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-01 10:06:38.028294 :9ED417C5:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-01 10:06:38.028813 :9ED417CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-01 10:06:38.129452 :9ED41AFA:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-01 10:06:38.134519 :9ED41B13:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:38.134561 :9ED41B16:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-06-01 10:06:38.139777 :9ED41B26:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:38.278717 :9ED41B3A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:38.415874 :9ED41B42:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:38.551611 :9ED41B4A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.669483 :9ED41BB2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.670517 :9ED41BBA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.676022 :9ED41BC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.691290 :9ED41BCA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.691952 :9ED41BD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.692494 :9ED41BDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.692994 :9ED41BE2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.695723 :9ED41BEA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.696624 :9ED41BF2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-06-01 10:06:39.697411 :9ED41BF3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-06-01 10:06:39.698252 :9ED41BF4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-06-01 10:06:39.698708 :9ED41BF5:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-06-01 10:06:39.698715 :9ED41BF6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-06-01 10:06:39.699324 :9ED41BF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-06-01 10:06:39.699831 :9ED41BF8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-06-01 10:06:39.700154 :9ED41BF9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-06-01 10:06:39.701165 :9ED41BFA:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-06-01 10:06:39.742767 :9ED41BFB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.742837 :9ED41BFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-06-01 10:06:39.743793 :9ED41C04:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.744727 :9ED41C0C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-06-01 10:06:39.745180 :9ED41C0D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.754788*:9ED41C16:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A64228 estart=1748743598 eid=16777966 ctx=0x000000077B42EF30 cwh=0x00000000299A0608 cpu=0 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-01 10:06:39.754788*:9ED41C17:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A64228 curCtx=0x0000000029A7ACC8 pubTabIdxCnt=0 2025-06-01 10:06:39.754788*:9ED41C18:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A64228 2025-06-01 10:06:39.754788*:9ED41C1A:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A64228 2025-06-01 10:06:39.754788*:9ED41C1C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A4B420 estart=1748743598 eid=16777966 ctx=0x000000077B447BE8 cwh=0x000000002995CDE0 cpu=15625 buffg=633 interb=0 r=0 rb=0 w=0 wb=0 2025-06-01 10:06:39.754788*:9ED41C1D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A4B420 curCtx=0x0000000029A67450 pubTabIdxCnt=0 2025-06-01 10:06:39.754788*:9ED41C1E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A4B420 2025-06-01 10:06:39.754788*:9ED41C1F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A4B420 2025-06-01 10:06:39.754788*:9ED41C20:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D57098 estart=1748743598 eid=16777966 ctx=0x000000077B458BE8 cwh=0x0000000029AB07F0 cpu=15625 buffg=678 interb=0 r=0 rb=0 w=0 wb=0 2025-06-01 10:06:39.754788*:9ED41C21:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D57098 curCtx=0x0000000029B19488 pubTabIdxCnt=0 2025-06-01 10:06:39.754788*:9ED41C22:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D57098 2025-06-01 10:06:39.754788*:9ED41C23:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D57098 2025-06-01 10:06:39.754788*:9ED41C24:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A64228 curCtx=0x0000000029A7ACC8 xsc->flg4=65792 flags=1 2025-06-01 10:06:39.754788*:9ED41C25:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A64228 2025-06-01 10:06:39.754788*:9ED41C26:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A4B420 curCtx=0x0000000029A67450 xsc->flg4=65792 flags=1 2025-06-01 10:06:39.754788*:9ED41C27:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A4B420 2025-06-01 10:06:39.754788*:9ED41C28:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D57098 curCtx=0x0000000029B19488 xsc->flg4=65792 flags=2 2025-06-01 10:06:39.754788*:9ED41C29:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D57098 2025-06-01 10:06:39.765311 :9ED41C2A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.765364 :9ED41C2D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-06-01 10:06:39.766338 :9ED41C33:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.766836 :9ED41C3B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.767225 :9ED41C45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.767417 :9ED41C5A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.767556 :9ED41C62:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.767709 :9ED41C6A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-06-01 10:06:39.772016 :9ED41C6B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.772097 :9ED41C6E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:26:209] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-06-01 10:06:39.772179 :9ED41C7B:db_trace:ksl2.c@12699:ksliwat(): [10005:26:209] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 26 (osid: 14596, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de