Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250716220009\orcl_j001_16700_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250716220009\orcl_j001_16700_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:36286M/63366M, Ph+PgF:42258M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 16700, image: ORACLE.EXE (J001) *** 2025-07-16 22:00:09.844 *** SESSION ID:(201.49201) 2025-07-16 22:00:09.844 *** 2025-07-16 22:00:09.844 Process diagnostic dump for ORACLE.EXE (J001), OS id=16700, pid: 25, proc_ser: 184, sid: 201, sess_ser: 49201 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 16700 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=16 seq_num=17 snap_id=1 wait times: snap=0.320841 sec, exc=0.320841 sec, total=0.320841 sec wait times: max=0.500000 sec, heur=7.777841 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.000008 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=15 seq_num=16 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.000011 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=14 seq_num=15 snap_id=1 wait times: snap=0.500113 sec, exc=0.500113 sec, total=0.500113 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=13 seq_num=14 snap_id=1 wait times: snap=0.499999 sec, exc=0.499999 sec, total=0.499999 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=12 seq_num=13 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.000008 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.499985 sec, exc=0.499985 sec, total=0.499985 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000007 sec of elapsed time 5: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.500010 sec, exc=0.500010 sec, total=0.500010 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=9 seq_num=10 snap_id=1 wait times: snap=0.514094 sec, exc=0.514094 sec, total=0.514094 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=8 seq_num=9 snap_id=1 wait times: snap=0.500290 sec, exc=0.500290 sec, total=0.500290 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 snap_id=1 wait times: snap=0.499990 sec, exc=0.499990 sec, total=0.499990 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000005 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=6 seq_num=7 snap_id=1 wait times: snap=0.500009 sec, exc=0.500009 sec, total=0.500009 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000009 sec of elapsed time Sampled Session History of session 201 serial 49201 --------------------------------------------------- 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 --------------------------------------------------- [8 samples, 22:00:02 - 22:00:09] idle wait at each sample [session created at: 22:00:02] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-07-16 22:00:09.844 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 16700, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-16 21:48:36.702755 :B2EDAA67:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:48:36.702755 :B2EDAA68:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:48:36.702756 :B2EDAA69:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:48:36.702756 :B2EDAA6A:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:48:36.702756 :B2EDAA6B:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:48:36.703261 :B2EDAA6C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:49:06.750627 :B2EDB439:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:49:36.808136 :B2EDBE13:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:49:36.797 2025-07-16 21:49:36.808138 :B2EDBE14:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18184 pso_num=25 pso_serial#=174 2025-07-16 21:49:36.808287 :B2EDBE15:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18184 osp_idx=23 osp_ver=199951 osp_pg=0 (spawn #392478) 2025-07-16 21:49:36.808288 :B2EDBE16:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:49:36.808288 :B2EDBE17:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=201 time=1383352689 2025-07-16 21:49:36.808289 :B2EDBE18:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:49:36.808289 :B2EDBE19:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:49:36.808290 :B2EDBE1A:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:49:36.808290 :B2EDBE1B:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:49:36.808290 :B2EDBE1C:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:49:36.808782 :B2EDBE1D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:50:06.876646 :B2EDC7D4:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:50:36.887508 :B2EDD1DB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:50:36.875 2025-07-16 21:50:36.887511 :B2EDD1DC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7880 pso_num=25 pso_serial#=175 2025-07-16 21:50:36.887651 :B2EDD1DD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7880 osp_idx=23 osp_ver=199952 osp_pg=0 (spawn #392480) 2025-07-16 21:50:36.887651 :B2EDD1DE:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:50:36.887652 :B2EDD1DF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=202 time=1383412767 2025-07-16 21:50:36.887652 :B2EDD1E0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:50:36.887653 :B2EDD1E1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:50:36.887653 :B2EDD1E2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:50:36.887654 :B2EDD1E3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:50:36.887655 :B2EDD1E4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:50:36.888213 :B2EDD1E5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:51:06.990260 :B2EDDBD6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:51:36.988555 :B2EDE5C5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:51:36.977 2025-07-16 21:51:36.988558 :B2EDE5C6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10600 pso_num=25 pso_serial#=176 2025-07-16 21:51:36.988695 :B2EDE5C7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10600 osp_idx=23 osp_ver=199953 osp_pg=0 (spawn #392482) 2025-07-16 21:51:36.988696 :B2EDE5C8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:51:36.988696 :B2EDE5C9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=203 time=1383472876 2025-07-16 21:51:36.988697 :B2EDE5CA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:51:36.988697 :B2EDE5CB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:51:36.988697 :B2EDE5CC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:51:36.988698 :B2EDE5CD:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:51:36.988698 :B2EDE5CE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:51:36.989192 :B2EDE5CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:52:07.087134 :B2EDEFA5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:52:37.108638 :B2EDF97C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:52:37.098 2025-07-16 21:52:37.108640 :B2EDF97D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17708 pso_num=25 pso_serial#=177 2025-07-16 21:52:37.108779 :B2EDF97E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17708 osp_idx=23 osp_ver=199954 osp_pg=0 (spawn #392484) 2025-07-16 21:52:37.108780 :B2EDF97F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:52:37.108780 :B2EDF980:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=204 time=1383533001 2025-07-16 21:52:37.108782 :B2EDF981:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:52:37.108783 :B2EDF982:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:52:37.108783 :B2EDF983:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:52:37.108783 :B2EDF984:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:52:37.108784 :B2EDF985:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:52:37.109282 :B2EDF986:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:53:07.191552 :B2EE0425:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:53:37.193736 :B2EE0DD0:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:53:37.183 2025-07-16 21:53:37.193739 :B2EE0DD1:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17880 pso_num=25 pso_serial#=178 2025-07-16 21:53:37.193876 :B2EE0DD2:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17880 osp_idx=23 osp_ver=199955 osp_pg=0 (spawn #392486) 2025-07-16 21:53:37.193877 :B2EE0DD3:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:53:37.193877 :B2EE0DD4:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=205 time=1383593079 2025-07-16 21:53:37.193878 :B2EE0DD5:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:53:37.193879 :B2EE0DD6:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:53:37.193879 :B2EE0DD7:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:53:37.193879 :B2EE0DD8:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:53:37.193880 :B2EE0DD9:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:53:37.194364 :B2EE0DDA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:54:07.263795 :B2EE17F5:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:54:37.268060 :B2EE21EC:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:54:37.257 2025-07-16 21:54:37.268062 :B2EE21ED:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=10916 pso_num=25 pso_serial#=179 2025-07-16 21:54:37.268197 :B2EE21EE:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=10916 osp_idx=23 osp_ver=199956 osp_pg=0 (spawn #392490) 2025-07-16 21:54:37.268197 :B2EE21EF:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:54:37.268198 :B2EE21F0:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=206 time=1383653158 2025-07-16 21:54:37.268198 :B2EE21F1:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:54:37.268199 :B2EE21F2:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:54:37.268199 :B2EE21F3:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:54:37.268199 :B2EE21F4:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:54:37.268199 :B2EE21F5:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:54:37.268677 :B2EE21F6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:55:07.360228 :B2EE2BBF:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:55:37.370566 :B2EE357A:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:55:37.359 2025-07-16 21:55:37.370568 :B2EE357B:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15184 pso_num=25 pso_serial#=180 2025-07-16 21:55:37.370690 :B2EE357C:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15184 osp_idx=23 osp_ver=199957 osp_pg=0 (spawn #392492) 2025-07-16 21:55:37.370691 :B2EE357D:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:55:37.370692 :B2EE357E:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=207 time=1383713251 2025-07-16 21:55:37.370692 :B2EE357F:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:55:37.370692 :B2EE3580:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:55:37.370693 :B2EE3581:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:55:37.370693 :B2EE3582:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:55:37.370694 :B2EE3583:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:55:37.371166 :B2EE3584:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:56:07.467708 :B2EE3F8C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:56:37.469538 :B2EE4941:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:56:37.458 2025-07-16 21:56:37.469540 :B2EE4942:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=14912 pso_num=25 pso_serial#=181 2025-07-16 21:56:37.469678 :B2EE4943:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=14912 osp_idx=23 osp_ver=199958 osp_pg=0 (spawn #392494) 2025-07-16 21:56:37.469678 :B2EE4944:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:56:37.469679 :B2EE4945:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=208 time=1383773361 2025-07-16 21:56:37.469679 :B2EE4946:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:56:37.469680 :B2EE4947:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:56:37.469680 :B2EE4948:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:56:37.469681 :B2EE4949:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:56:37.469681 :B2EE494A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:56:37.470170 :B2EE494B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:57:07.561785 :B2EE52F0:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:57:37.584338 :B2EE5CAF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:57:37.572 2025-07-16 21:57:37.584340 :B2EE5CB0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=1740 pso_num=25 pso_serial#=182 2025-07-16 21:57:37.584457 :B2EE5CB1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=1740 osp_idx=23 osp_ver=199959 osp_pg=0 (spawn #392496) 2025-07-16 21:57:37.584458 :B2EE5CB2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:57:37.584458 :B2EE5CB3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=209 time=1383833470 2025-07-16 21:57:37.584459 :B2EE5CB4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:57:37.584459 :B2EE5CB5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:57:37.584459 :B2EE5CB6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:57:37.584460 :B2EE5CB7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:57:37.584460 :B2EE5CB8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:57:37.584962 :B2EE5CB9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:58:02.596307 :B2EE6578:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-16 21:58:02.596337*:B2EE6579:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BDBB58 estart=1752674281 eid=16960371 ctx=0x000000077BD98A08 cwh=0x0000000026B901B0 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-16 21:58:02.596337*:B2EE657A:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BDBB58 curCtx=0x0000000026B9F708 pubTabIdxCnt=0 2025-07-16 21:58:02.596337*:B2EE657B:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BDBB58 2025-07-16 21:58:02.596337*:B2EE657C:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BDBB58 2025-07-16 21:58:02.596337*:B2EE657D:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BDBB58 curCtx=0x0000000026B9F708 xsc->flg4=65792 flags=2 2025-07-16 21:58:02.596337*:B2EE657E:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BDBB58 2025-07-16 21:58:02.596973 :B2EE657F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:02.602431 :B2EE6587:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:02.603430 :B2EE658F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 21:58:02.603563 :B2EE6598:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 21:58:32.683399 :B2EE6EDD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:58:37.650873 :B2EE70C5:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:58:37.639 2025-07-16 21:58:37.650875 :B2EE70C6:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7692 pso_num=25 pso_serial#=183 2025-07-16 21:58:37.650998 :B2EE70C7:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7692 osp_idx=23 osp_ver=199960 osp_pg=0 (spawn #392498) 2025-07-16 21:58:37.650998 :B2EE70C8:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:58:37.650999 :B2EE70C9:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=210 time=1383893533 2025-07-16 21:58:37.650999 :B2EE70CA:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:58:37.651000 :B2EE70CB:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:58:37.651000 :B2EE70CC:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:58:37.651001 :B2EE70CD:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:58:37.651001 :B2EE70CE:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:58:37.651490 :B2EE70CF:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 21:59:07.737199 :B2EE7A51:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-16 21:59:37.757577 :B2EE844C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-16 21:59:37.746 2025-07-16 21:59:37.757579 :B2EE844D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16700 pso_num=25 pso_serial#=184 2025-07-16 21:59:37.757700 :B2EE844E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16700 osp_idx=23 osp_ver=199961 osp_pg=0 (spawn #392500) 2025-07-16 21:59:37.757701 :B2EE844F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-07-16 21:59:37.757701 :B2EE8450:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=211 time=1383953642 2025-07-16 21:59:37.757701 :B2EE8451:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-16 21:59:37.757702 :B2EE8452:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-16 21:59:37.757702 :B2EE8453:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-16 21:59:37.757702 :B2EE8454:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-16 21:59:37.757703 :B2EE8455:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-16 21:59:37.758187 :B2EE8456:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.045718 :B2EE8DCE:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-16 22:00:02.045718*:B2EE8DF1:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BEB898 estart=1752674401 eid=16784304 ctx=0x000000077FD6A000 cwh=0x0000000026BE0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-16 22:00:02.045718*:B2EE8DF2:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BEB898 curCtx=0x0000000026BE7AB8 pubTabIdxCnt=0 2025-07-16 22:00:02.045718*:B2EE8DF3:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BEB898 2025-07-16 22:00:02.045718*:B2EE8DF4:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BEB898 2025-07-16 22:00:02.045718*:B2EE8E0F:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BEB898 curCtx=0x0000000026BE7AB8 xsc->flg4=65792 flags=2 2025-07-16 22:00:02.045718*:B2EE8E10:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BEB898 2025-07-16 22:00:02.052626 :B2EE8E11:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.052682 :B2EE8E14:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-07-16 22:00:02.058065 :B2EE8E42:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-07-16 22:00:02.058649 :B2EE8E43:db_trace:kcc.c@13684:kccwbp(): [10021:25:201:1] 0115000000000000 0115000000000000 9547120000000000 2025-07-16 22:00:02.060244 :B2EE8E44:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=15 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.060323 :B2EE8E51:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=15 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.060331 :B2EE8E58:db_trace:ksb.c@6610:ksbcic_int(): [10254:25:201] KSBCIC: (USER) starting cic on opcode KSBCIRCO [1] with args (1 8397264 1) 2025-07-16 22:00:02.060336 :B2EE8E59:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.060367 :B2EE8E66:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.061217 :B2EE8E70:db_trace:ksb.c@6610:ksbcic_int(): [10254:25:201] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (4 0 231568027) 2025-07-16 22:00:02.061223 :B2EE8E71:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.061251 :B2EE8E7C:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.061261 :B2EE8E89:db_trace:ksb.c@6610:ksbcic_int(): [10254:25:201] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (6 65561 1) 2025-07-16 22:00:02.061263 :B2EE8E8A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.061294 :B2EE8E96:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.061298 :B2EE8E99:db_trace:ksb.c@6610:ksbcic_int(): [10254:25:201] KSBCIC: (USER) starting cic on opcode KSBCICKP [2] with args (1 2 65561) 2025-07-16 22:00:02.061301 :B2EE8E9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.061351 :B2EE8EC0:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.061828 :B2EE8F7B:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=15 loc='ksq.h LINE:1877 ID:ksqrcl' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.061855 :B2EE8F8B:KFNU:kfn.c@2200:kfnPrepareASM(): kfnPrepareASM force=0 state_kfnsg=0x7 2025-07-16 22:00:02.062780 :B2EE8F8D:db_trace:kcc.c@13684:kccwbp(): [10021:25:201:1] 0115000000000000 0115000000000000 9647120000000000 2025-07-16 22:00:02.063166 :B2EE8F9B:db_trace:ksb.c@6610:ksbcic_int(): [10254:25:201] KSBCIC: (USER) starting cic on opcode KSBCIBBS [20] with args (2 0 231568027) 2025-07-16 22:00:02.063172 :B2EE8F9C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=15 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.063194 :B2EE8FA7:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=15 loc='ksa2.h LINE:286 ID:ksasnr' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-16 22:00:02.071860 :B2EE900C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-07-16 22:00:02.073640 :B2EE9015:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.073704 :B2EE9018:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='kkj.h LINE:928 ID:jslve_execute' id1=0 id2=0 name= type=0 2025-07-16 22:00:02.073783 :B2EE9025:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-07-16 22:00:02.170779 :B2EE9155:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] 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-16 22:00:04.017524 :B2EE9554:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 16700, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de