Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250701220008\orcl_j000_7692_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250701220008\orcl_j000_7692_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:36782M/63366M, Ph+PgF:42838M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 7692, image: ORACLE.EXE (J000) *** 2025-07-01 22:00:08.265 *** SESSION ID:(193.33779) 2025-07-01 22:00:08.265 *** 2025-07-01 22:00:08.265 Process diagnostic dump for ORACLE.EXE (J000), OS id=7692, pid: 24, proc_ser: 147, sid: 193, sess_ser: 33779 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 7692 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) 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.264536 sec, exc=0.264536 sec, total=0.264536 sec wait times: max=0.500000 sec, heur=4.250654 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.000014 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.500006 sec, exc=0.500006 sec, total=0.500006 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 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.499996 sec, exc=0.499996 sec, total=0.499996 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000011 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.499992 sec, exc=0.499992 sec, total=0.499992 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000013 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.500001 sec, exc=0.500001 sec, total=0.500001 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 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.500108 sec, exc=0.500108 sec, total=0.500108 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 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.499988 sec, exc=0.499988 sec, total=0.499988 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000018 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.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.000010 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.485939 sec, exc=0.485939 sec, total=0.485939 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 193 serial 33779 --------------------------------------------------- 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, 22:00:04 - 22:00:08] idle wait at each sample [session created at: 22:00:04] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-01 22:00:08.265 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 7692, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-01 21:51:14.706456 :AC4197B2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:51:44.793250 :AC41A184:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:52:14.791931 :AC41AB06:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:52:14.781 2025-07-01 21:52:14.791933 :AC41AB07:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17392 pso_num=24 pso_serial#=138 2025-07-01 21:52:14.792065 :AC41AB08:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17392 osp_idx=22 osp_ver=498928 osp_pg=0 (spawn #342481) 2025-07-01 21:52:14.792066 :AC41AB09:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:52:14.792066 :AC41AB0A:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=164 time=87510673 2025-07-01 21:52:14.792066 :AC41AB0B:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:52:14.792067 :AC41AB0C:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:52:14.792067 :AC41AB0D:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:52:14.792068 :AC41AB0E:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:52:14.792069 :AC41AB0F:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:52:14.792571 :AC41AB10:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:52:44.868353 :AC41B461:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:53:14.866328 :AC41BDF3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:53:14.855 2025-07-01 21:53:14.866331 :AC41BDF4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13220 pso_num=24 pso_serial#=139 2025-07-01 21:53:14.866449 :AC41BDF5:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13220 osp_idx=22 osp_ver=498929 osp_pg=0 (spawn #342483) 2025-07-01 21:53:14.866449 :AC41BDF6:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:53:14.866450 :AC41BDF7:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=165 time=87570751 2025-07-01 21:53:14.866450 :AC41BDF8:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:53:14.866450 :AC41BDF9:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:53:14.866451 :AC41BDFA:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:53:14.866451 :AC41BDFB:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:53:14.866451 :AC41BDFC:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:53:14.866925 :AC41BDFD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:53:44.926417 :AC41C750:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:54:14.966640 :AC41D0DC:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:54:14.955 2025-07-01 21:54:14.966642 :AC41D0DD:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13936 pso_num=24 pso_serial#=140 2025-07-01 21:54:14.966761 :AC41D0DE:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=13936 osp_idx=22 osp_ver=498930 osp_pg=0 (spawn #342485) 2025-07-01 21:54:14.966761 :AC41D0DF:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:54:14.966762 :AC41D0E0:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=166 time=87630861 2025-07-01 21:54:14.966762 :AC41D0E1:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:54:14.966762 :AC41D0E2:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:54:14.966763 :AC41D0E3:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:54:14.966763 :AC41D0E4:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:54:14.966763 :AC41D0E5:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:54:14.967232 :AC41D0E6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:54:39.998589 :AC41D8B5:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-01 21:55:10.101931 :AC41E24B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:55:15.055035 :AC41E412:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:55:15.044 2025-07-01 21:55:15.055038 :AC41E413:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17132 pso_num=24 pso_serial#=141 2025-07-01 21:55:15.055181 :AC41E414:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17132 osp_idx=22 osp_ver=498931 osp_pg=0 (spawn #342487) 2025-07-01 21:55:15.055182 :AC41E415:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:55:15.055182 :AC41E416:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=167 time=87690939 2025-07-01 21:55:15.055183 :AC41E417:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:55:15.055183 :AC41E418:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:55:15.055183 :AC41E419:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:55:15.055184 :AC41E41A:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:55:15.055184 :AC41E41B:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:55:15.055692 :AC41E41C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:55:45.154636 :AC41EDD1:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:56:15.130309 :AC41F748:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:56:15.119 2025-07-01 21:56:15.130311 :AC41F749:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7464 pso_num=24 pso_serial#=142 2025-07-01 21:56:15.130502 :AC41F74A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=7464 osp_idx=22 osp_ver=498932 osp_pg=0 (spawn #342489) 2025-07-01 21:56:15.130503 :AC41F74B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:56:15.130503 :AC41F74C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=168 time=87751017 2025-07-01 21:56:15.130504 :AC41F74D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:56:15.130504 :AC41F74E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:56:15.130505 :AC41F74F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:56:15.130505 :AC41F750:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:56:15.130505 :AC41F751:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:56:15.131004 :AC41F752:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:56:45.208545 :AC4201C8:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:57:15.231607 :AC420BCB:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:57:15.221 2025-07-01 21:57:15.231609 :AC420BCC:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17880 pso_num=24 pso_serial#=143 2025-07-01 21:57:15.231748 :AC420BCD:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17880 osp_idx=22 osp_ver=498933 osp_pg=0 (spawn #342492) 2025-07-01 21:57:15.231748 :AC420BCE:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:57:15.231749 :AC420BCF:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=169 time=87811126 2025-07-01 21:57:15.231749 :AC420BD0:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:57:15.231750 :AC420BD1:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:57:15.231750 :AC420BD2:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:57:15.231750 :AC420BD3:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:57:15.231751 :AC420BD4:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:57:15.232235 :AC420BD5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:57:45.305026 :AC42152B:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:58:15.345167 :AC421E8E:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:58:15.334 2025-07-01 21:58:15.345169 :AC421E8F:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12960 pso_num=24 pso_serial#=144 2025-07-01 21:58:15.345310 :AC421E90:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=12960 osp_idx=22 osp_ver=498934 osp_pg=0 (spawn #342494) 2025-07-01 21:58:15.345311 :AC421E91:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:58:15.345311 :AC421E92:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=170 time=87871236 2025-07-01 21:58:15.345311 :AC421E93:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:58:15.345312 :AC421E94:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:58:15.345312 :AC421E95:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:58:15.345312 :AC421E96:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:58:15.345313 :AC421E97:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:58:15.345798 :AC421E98:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:58:45.422419 :AC4227FE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 21:59:15.423374 :AC423186:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 21:59:15.410 2025-07-01 21:59:15.423377 :AC423187:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15628 pso_num=24 pso_serial#=145 2025-07-01 21:59:15.423543 :AC423188:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15628 osp_idx=22 osp_ver=498935 osp_pg=0 (spawn #342496) 2025-07-01 21:59:15.423544 :AC423189:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 21:59:15.423544 :AC42318A:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=171 time=87931314 2025-07-01 21:59:15.423544 :AC42318B:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 21:59:15.423545 :AC42318C:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 21:59:15.423545 :AC42318D:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 21:59:15.423546 :AC42318E:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 21:59:15.423546 :AC42318F:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 21:59:15.424085 :AC423190:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 21:59:45.468973 :AC423BA0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:00:00.047736 :AC4240A3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:00:00.038 2025-07-01 22:00:00.047738 :AC4240A4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9248 pso_num=24 pso_serial#=146 2025-07-01 22:00:00.047871 :AC4240A5:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=9248 osp_idx=22 osp_ver=498936 osp_pg=0 (spawn #342498) 2025-07-01 22:00:00.047872 :AC4240A6:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 22:00:00.047872 :AC4240A7:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=172 time=87975939 2025-07-01 22:00:00.047872 :AC4240A8:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:00:00.047873 :AC4240A9:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:00:00.047873 :AC4240AA:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:00:00.047873 :AC4240AB:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:00:00.047874 :AC4240AC:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:00:00.048402 :AC4240AD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.048445 :AC4240B4:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-01 22:00:00.048523 :AC4240C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.052412 :AC4240D7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.053612 :AC4240DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.053636 :AC4240E2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.053675 :AC4240ED:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-01 22:00:00.055420 :AC4240F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.055443 :AC4240FB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.055537 :AC424106:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-01 22:00:00.055996 :AC424111:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.058641 :AC424119:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.063953 :AC424121:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.069284 :AC424129:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.070676 :AC424131:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.073817 :AC424139:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.075094 :AC424141:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.078099 :AC424149:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.081407 :AC424151:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.081878 :AC424160:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.081927 :AC424163:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-07-01 22:00:00.081942 :AC424164:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-07-01 22:00:00.083998 :AC42416A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.084044 :AC42416D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-07-01 22:00:00.084055 :AC42416E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-07-01 22:00:00.086041 :AC424174:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.086087 :AC424177:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-07-01 22:00:00.086099 :AC424178:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-07-01 22:00:00.086307 :AC42417E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.086326 :AC424181:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.086377 :AC42418C:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-01 22:00:00.087887 :AC424197:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-07-01 22:00:00.481649 :AC4241D5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 07-01 22:00:00.476 2025-07-01 22:00:00.481651 :AC4241D6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=7692 pso_num=24 pso_serial#=147 2025-07-01 22:00:00.481790 :AC4241D7:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=7692 osp_idx=22 osp_ver=498937 osp_pg=0 (spawn #342499) 2025-07-01 22:00:00.481791 :AC4241D8:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-01 22:00:00.481791 :AC4241D9:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=173 time=87976376 2025-07-01 22:00:00.481792 :AC4241DA:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-07-01 22:00:00.481792 :AC4241DB:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-07-01 22:00:00.481792 :AC4241DC:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-07-01 22:00:00.481793 :AC4241DD:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-01 22:00:00.481793 :AC4241DE:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-01 22:00:00.482290 :AC4241DF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.487491 :AC4241FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.487537 :AC424201:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-01 22:00:00.499071 :AC42425F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.504408 :AC424287:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.505171 :AC4242A1:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.510851 :AC4243E7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.511008 :AC4243FD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.511804 :AC42440F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.512064 :AC424417:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-01 22:00:00.513652 :AC424418:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.513693 :AC42441B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.513766 :AC424428:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-01 22:00:00.617139 :AC424528:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-01 22:00:00.619367 :AC42452C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.619406 :AC42452F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-01 22:00:00.621850 :AC424535:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-01 22:00:00.625167 :AC424536:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.625252 :AC424539:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-01 22:00:00.625358 :AC424546:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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-07-01 22:00:04.015626 :AC424A2A:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-01 22:00:04.015626*:AC424A2E:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1751378403 eid=16783390 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-01 22:00:04.015626*:AC424A2F:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-07-01 22:00:04.015626*:AC424A30:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-07-01 22:00:04.015626*:AC424A31:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-07-01 22:00:04.015626*:AC424A32:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-07-01 22:00:04.015626*:AC424A33:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-07-01 22:00:04.018047 :AC424A34:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:04.018087 :AC424A37:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-07-01 22:00:04.024775 :AC424A3D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:04.025538 :AC424A45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:04.026271 :AC424A4D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:04.026471 :AC424A55:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:jslv.c:9203 2025-07-01 22:00:04.027897 :AC424A56:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-01 22:00:04.027941 :AC424A59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-01 22:00:04.028028 :AC424A66:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] 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 24 (osid: 7692, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de