Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250913180427\orcl_j001_22496_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250913180427\orcl_j001_22496_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:34775M/63366M, Ph+PgF:39418M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 26 Windows thread id: 22496, image: ORACLE.EXE (J001) *** 2025-09-13 18:04:27.610 *** SESSION ID:(209.50713) 2025-09-13 18:04:27.610 *** 2025-09-13 18:04:27.610 Process diagnostic dump for ORACLE.EXE (J001), OS id=22496, pid: 26, proc_ser: 235, sid: 209, sess_ser: 50713 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 22496 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.342940 sec, exc=0.342940 sec, total=0.342940 sec wait times: max=0.500000 sec, heur=5.345106 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.000011 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.499987 sec, exc=0.499987 sec, total=0.499987 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.502069 sec, exc=0.502069 sec, total=0.502069 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000023 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.500011 sec, exc=0.500011 sec, total=0.500011 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.499995 sec, exc=0.499995 sec, total=0.499995 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499986 sec, exc=0.499986 sec, total=0.499986 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000014 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.499998 sec, exc=0.499998 sec, total=0.499998 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.501035 sec, exc=0.501035 sec, total=0.501035 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000025 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 snap_id=1 wait times: snap=0.500033 sec, exc=0.500033 sec, total=0.500033 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.498910 sec, exc=0.498910 sec, total=0.498910 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 50713 --------------------------------------------------- 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 --------------------------------------------------- [6 samples, 18:04:22 - 18:04:27] idle wait at each sample [session created at: 18:04:22] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-09-13 18:04:27.610 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 26 (osid: 22496, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-09-13 17:55:18.867961 :CCF42091:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23684 pso_num=26 pso_serial#=226 2025-09-13 17:55:18.868079 :CCF42092:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23684 osp_idx=24 osp_ver=842501 osp_pg=0 (spawn #588605) 2025-09-13 17:55:18.868080 :CCF42093:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 17:55:18.868080 :CCF42094:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=27 time=2171770158 2025-09-13 17:55:18.868081 :CCF42095:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 17:55:18.868081 :CCF42096:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 17:55:18.868082 :CCF42097:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 17:55:18.868082 :CCF42098:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 17:55:18.868082 :CCF42099:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 17:55:18.868608 :CCF4209A: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-09-13 17:55:48.968275 :CCF42AB0:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 17:56:18.936782 :CCF43493:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 17:56:18.926 2025-09-13 17:56:18.936785 :CCF43494:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23088 pso_num=26 pso_serial#=227 2025-09-13 17:56:18.936914 :CCF43495:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23088 osp_idx=24 osp_ver=842502 osp_pg=0 (spawn #588607) 2025-09-13 17:56:18.936914 :CCF43496:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 17:56:18.936915 :CCF43497:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=28 time=2171830237 2025-09-13 17:56:18.936916 :CCF43498:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 17:56:18.936916 :CCF43499:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 17:56:18.936916 :CCF4349A:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 17:56:18.936917 :CCF4349B:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 17:56:18.936917 :CCF4349C:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 17:56:18.937380 :CCF4349D: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-09-13 17:56:49.021597 :CCF43E69:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 17:57:19.023140 :CCF4481A:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 17:57:19.012 2025-09-13 17:57:19.023143 :CCF4481B:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=23080 pso_num=26 pso_serial#=228 2025-09-13 17:57:19.023263 :CCF4481C:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=23080 osp_idx=24 osp_ver=842503 osp_pg=0 (spawn #588609) 2025-09-13 17:57:19.023264 :CCF4481D:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 17:57:19.023264 :CCF4481E:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=29 time=2171890315 2025-09-13 17:57:19.023265 :CCF4481F:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 17:57:19.023265 :CCF44820:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 17:57:19.023266 :CCF44821:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 17:57:19.023266 :CCF44822:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 17:57:19.023266 :CCF44823:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 17:57:19.023761 :CCF44824: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-09-13 17:57:49.110418 :CCF45256:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 17:58:19.113798 :CCF45BFC:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 17:58:19.103 2025-09-13 17:58:19.113800 :CCF45BFD:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25440 pso_num=26 pso_serial#=229 2025-09-13 17:58:19.113926 :CCF45BFE:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=25440 osp_idx=24 osp_ver=842504 osp_pg=0 (spawn #588611) 2025-09-13 17:58:19.113926 :CCF45BFF:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 17:58:19.113926 :CCF45C00:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=30 time=2171950408 2025-09-13 17:58:19.113927 :CCF45C01:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 17:58:19.113927 :CCF45C02:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 17:58:19.113928 :CCF45C03:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 17:58:19.113928 :CCF45C04:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 17:58:19.113928 :CCF45C05:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 17:58:19.114409 :CCF45C06: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-09-13 17:58:49.194637 :CCF46644:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 17:59:19.175917 :CCF47000:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 17:59:19.164 2025-09-13 17:59:19.175919 :CCF47001:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25384 pso_num=26 pso_serial#=230 2025-09-13 17:59:19.176035 :CCF47002:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=25384 osp_idx=24 osp_ver=842505 osp_pg=0 (spawn #588613) 2025-09-13 17:59:19.176036 :CCF47003:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 17:59:19.176036 :CCF47004:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=31 time=2172010471 2025-09-13 17:59:19.176037 :CCF47005:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 17:59:19.176037 :CCF47006:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 17:59:19.176038 :CCF47007:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 17:59:19.176038 :CCF47008:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 17:59:19.176039 :CCF47009:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 17:59:19.176551 :CCF4700A: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-09-13 17:59:49.265448 :CCF479F3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 18:00:19.270649 :CCF483E0:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 18:00:19.259 2025-09-13 18:00:19.270652 :CCF483E1:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=25092 pso_num=26 pso_serial#=231 2025-09-13 18:00:19.270838 :CCF483E2:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=25092 osp_idx=24 osp_ver=842506 osp_pg=0 (spawn #588615) 2025-09-13 18:00:19.270839 :CCF483E3:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 18:00:19.270839 :CCF483E4:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=32 time=2172070565 2025-09-13 18:00:19.270839 :CCF483E5:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 18:00:19.270840 :CCF483E6:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 18:00:19.270841 :CCF483E7:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 18:00:19.270841 :CCF483E8:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 18:00:19.270841 :CCF483E9:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 18:00:19.271325 :CCF483EA: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-09-13 18:00:49.362227 :CCF48FC3:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 18:01:19.370264 :CCF49938:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 18:01:19.359 2025-09-13 18:01:19.370266 :CCF49939:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=24668 pso_num=26 pso_serial#=232 2025-09-13 18:01:19.370417 :CCF4993A:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=24668 osp_idx=24 osp_ver=842507 osp_pg=0 (spawn #588619) 2025-09-13 18:01:19.370418 :CCF4993B:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 18:01:19.370418 :CCF4993C:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=33 time=2172130674 2025-09-13 18:01:19.370419 :CCF4993D:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 18:01:19.370419 :CCF4993E:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 18:01:19.370419 :CCF4993F:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 18:01:19.370419 :CCF49940:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 18:01:19.370419 :CCF49941:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 18:01:19.370897 :CCF49942: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-09-13 18:01:49.419198 :CCF4A2F2:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 18:02:04.408102 :CCF4A81C:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 18:02:04.396 2025-09-13 18:02:04.408105 :CCF4A81D:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22056 pso_num=26 pso_serial#=233 2025-09-13 18:02:04.408250 :CCF4A81E:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22056 osp_idx=24 osp_ver=842508 osp_pg=0 (spawn #588621) 2025-09-13 18:02:04.408251 :CCF4A81F:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 18:02:04.408251 :CCF4A820:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=34 time=2172175705 2025-09-13 18:02:04.408252 :CCF4A821:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 18:02:04.408252 :CCF4A822:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 18:02:04.408253 :CCF4A823:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 18:02:04.408253 :CCF4A824:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 18:02:04.408253 :CCF4A825:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 18:02:04.408758 :CCF4A826: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-09-13 18:02:19.415814 :CCF4ACE3: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-09-13 18:02:49.515127 :CCF4B789:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 18:03:19.500120 :CCF4C147:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 18:03:19.489 2025-09-13 18:03:19.500122 :CCF4C148:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22692 pso_num=26 pso_serial#=234 2025-09-13 18:03:19.500241 :CCF4C149:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22692 osp_idx=24 osp_ver=842509 osp_pg=0 (spawn #588623) 2025-09-13 18:03:19.500242 :CCF4C14A:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 18:03:19.500242 :CCF4C14B:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=35 time=2172250799 2025-09-13 18:03:19.500243 :CCF4C14C:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 18:03:19.500243 :CCF4C14D:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 18:03:19.500243 :CCF4C14E:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 18:03:19.500244 :CCF4C14F:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 18:03:19.500244 :CCF4C150:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 18:03:19.500722 :CCF4C151: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-09-13 18:03:49.598219 :CCF4CB8A:db_trace:kst.c@698:kstpsodel(): [10280:26:0] kst: process state object about to be deleted 2025-09-13 18:04:19.581590 :CCF4D4B3:db_trace:kst.c@673:kstipg(): [10280:26:0] kst: process state object created on 09-13 18:04:19.570 2025-09-13 18:04:19.581592 :CCF4D4B4:db_trace:kst.c@679:kstipg(): [10280:26:0] kst: process info: ospid=22496 pso_num=26 pso_serial#=235 2025-09-13 18:04:19.581711 :CCF4D4B5:db_trace:kso.c@4093:ksonfy(): [10420:26:0] kso: new process: pid=22496 osp_idx=24 osp_ver=842510 osp_pg=0 (spawn #588625) 2025-09-13 18:04:19.581712 :CCF4D4B6:db_trace:kso.c@4099:ksonfy(): [10420:26:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-09-13 18:04:19.581712 :CCF4D4B7:db_trace:kso.c@4103:ksonfy(): [10420:26:0] kso: new process: pso_index=26 reservation=36 time=2172310877 2025-09-13 18:04:19.581713 :CCF4D4B8:db_trace:kso.c@4109:ksonfy(): [10420:26:0] kso: spawn diagnostics: queue time=0 secs 2025-09-13 18:04:19.581713 :CCF4D4B9:db_trace:kso.c@4111:ksonfy(): [10420:26:0] kso: spawn diagnostics: fork time=0 secs 2025-09-13 18:04:19.581713 :CCF4D4BA:db_trace:kso.c@4113:ksonfy(): [10420:26:0] kso: spawn diagnostics: exec time=0 secs 2025-09-13 18:04:19.581714 :CCF4D4BB:db_trace:kso.c@4115:ksonfy(): [10420:26:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-09-13 18:04:19.581714 :CCF4D4BC:db_trace:kso.c@4117:ksonfy(): [10420:26:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-09-13 18:04:19.582195 :CCF4D4BD: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-09-13 18:04:20.502878 :CCF4D6D0: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-09-13 18:04:20.601852 :CCF4DA0A: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-09-13 18:04:20.607214 :CCF4DA23: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-09-13 18:04:20.607258 :CCF4DA26:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:jslv.c:9203 2025-09-13 18:04:20.611382 :CCF4DA36: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-09-13 18:04:20.716752 :CCF4DA3E: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-09-13 18:04:20.845262 :CCF4DA46: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-09-13 18:04:20.972298 :CCF4DA4E: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-09-13 18:04:21.007358*:CCF4DA56:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DB5ED08 estart=1757757860 eid=16777584 ctx=0x000000077F658478 cwh=0x0000000028BB03D8 cpu=46875 buffg=9225 interb=0 r=0 rb=0 w=0 wb=0 2025-09-13 18:04:21.007358*:CCF4DA59:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DB5ED08 curCtx=0x000000002DB8E4B8 pubTabIdxCnt=0 2025-09-13 18:04:21.007358*:CCF4DA5B:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DB5ED08 2025-09-13 18:04:21.007358*:CCF4DA5C:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DB5ED08 2025-09-13 18:04:21.022986*:CCF4DA5D:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DB5ED08 curCtx=0x000000002DB8E4B8 xsc->flg4=65792 flags=1 2025-09-13 18:04:21.022986*:CCF4DA5E:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DB5ED08 2025-09-13 18:04:22.088867 :CCF4DA6E: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-09-13 18:04:22.092106 :CCF4DA83: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-09-13 18:04:22.093099 :CCF4DA8B: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-09-13 18:04:22.095264 :CCF4DA93: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-09-13 18:04:22.096881 :CCF4DA9B: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-09-13 18:04:22.099510 :CCF4DAA3: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-09-13 18:04:22.101142 :CCF4DAAD: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-09-13 18:04:22.117794 :CCF4DAC3: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-09-13 18:04:22.118461 :CCF4DACB: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-09-13 18:04:22.119004 :CCF4DAD3: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-09-13 18:04:22.119558 :CCF4DADB: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-09-13 18:04:22.122182 :CCF4DAE3: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-09-13 18:04:22.123087 :CCF4DAEB:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.123886 :CCF4DAEC:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.124677 :CCF4DAED:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.125088 :CCF4DAEE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.125098 :CCF4DAEF:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.125716 :CCF4DAF0:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.126209 :CCF4DAF1:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.126509 :CCF4DAF2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.127549 :CCF4DAF3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.164968 :CCF4DAF4: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-09-13 18:04:22.165015 :CCF4DAF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.165818 :CCF4DAFD: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-09-13 18:04:22.166700 :CCF4DB05:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.167142 :CCF4DB06: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-09-13 18:04:22.185072 :CCF4DB0E: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-09-13 18:04:22.185124 :CCF4DB11:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.185889 :CCF4DB17: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-09-13 18:04:22.186704 :CCF4DB1F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.187141 :CCF4DB20: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-09-13 18:04:22.207621 :CCF4DB2C: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-09-13 18:04:22.207685 :CCF4DB2F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.208554 :CCF4DB37: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-09-13 18:04:22.220846 :CCF4DB41:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.221435 :CCF4DB42: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-09-13 18:04:22.241830 :CCF4DB8C: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-09-13 18:04:22.241877 :CCF4DB8F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.242693 :CCF4DB95: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-09-13 18:04:22.243568 :CCF4DB9D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpus:psdpgi.c:2235 2025-09-13 18:04:22.244149 :CCF4DB9E: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-09-13 18:04:22.265256 :CCF4DBA6: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-09-13 18:04:22.265307 :CCF4DBA9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:psdpgi.c:2235 2025-09-13 18:04:22.266079 :CCF4DBAF: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-09-13 18:04:22.266528 :CCF4DBB7: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-09-13 18:04:22.266875 :CCF4DBBF: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-09-13 18:04:22.267117 :CCF4DBC7: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-09-13 18:04:22.267252 :CCF4DBCF: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-09-13 18:04:22.267397 :CCF4DBD7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:26:209] atxpop:jslv.c:9203 2025-09-13 18:04:22.271480 :CCF4DBD8: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-09-13 18:04:22.271562 :CCF4DBDB: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-09-13 18:04:22.271643 :CCF4DBE8: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: 22496, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de