Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250729220009\orcl_j001_19116_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250729220009\orcl_j001_19116_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:35918M/63366M, Ph+PgF:41650M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 19116, image: ORACLE.EXE (J001) *** 2025-07-29 22:00:09.809 *** SESSION ID:(201.30709) 2025-07-29 22:00:09.809 *** 2025-07-29 22:00:09.809 Process diagnostic dump for ORACLE.EXE (J001), OS id=19116, pid: 25, proc_ser: 232, sid: 201, sess_ser: 30709 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19116 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=11 seq_num=12 snap_id=1 wait times: snap=0.287189 sec, exc=0.287189 sec, total=0.287189 sec wait times: max=0.500000 sec, heur=5.792168 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.000015 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=10 seq_num=11 snap_id=1 wait times: snap=0.499972 sec, exc=0.499972 sec, total=0.499972 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=9 seq_num=10 snap_id=1 wait times: snap=0.500046 sec, exc=0.500046 sec, total=0.500046 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=8 seq_num=9 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.000010 sec of elapsed time 3: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=7 seq_num=8 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=6 seq_num=7 snap_id=1 wait times: snap=0.505095 sec, exc=0.505095 sec, total=0.505095 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=5 seq_num=6 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.000010 sec of elapsed time 6: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 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.000012 sec of elapsed time 7: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.500000 sec, exc=0.500000 sec, total=0.500000 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 8: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 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.000011 sec of elapsed time 9: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=1 seq_num=2 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 Sampled Session History of session 201 serial 30709 --------------------------------------------------- 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, 22:00:04 - 22:00:09] 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-29 22:00:09.809 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 19116, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-07-29 21:48:37.552675 :B8B5C043:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=33 time=2506493439 2025-07-29 21:48:37.552675 :B8B5C044:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:48:37.552675 :B8B5C045:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:48:37.552676 :B8B5C046:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:48:37.552676 :B8B5C047:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:48:37.552676 :B8B5C048:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:48:37.553173 :B8B5C049: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-29 21:49:07.632550 :B8B5CAE6:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:49:37.667223 :B8B5D459:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:49:37.654 2025-07-29 21:49:37.667225 :B8B5D45A:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17492 pso_num=25 pso_serial#=222 2025-07-29 21:49:37.667345 :B8B5D45B:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17492 osp_idx=23 osp_ver=221419 osp_pg=0 (spawn #435800) 2025-07-29 21:49:37.667345 :B8B5D45C: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-29 21:49:37.667346 :B8B5D45D:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=34 time=2506553548 2025-07-29 21:49:37.667346 :B8B5D45E:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:49:37.667347 :B8B5D45F:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:49:37.667347 :B8B5D460:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:49:37.667347 :B8B5D461:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:49:37.667348 :B8B5D462:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:49:37.667921 :B8B5D463: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-29 21:50:07.742965 :B8B5DDDE:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:50:37.755562 :B8B5E7A3:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:50:37.745 2025-07-29 21:50:37.755564 :B8B5E7A4:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=16248 pso_num=25 pso_serial#=223 2025-07-29 21:50:37.755695 :B8B5E7A5:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=16248 osp_idx=23 osp_ver=221420 osp_pg=0 (spawn #435802) 2025-07-29 21:50:37.755696 :B8B5E7A6: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-29 21:50:37.755696 :B8B5E7A7:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=35 time=2506613642 2025-07-29 21:50:37.755697 :B8B5E7A8:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:50:37.755697 :B8B5E7A9:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:50:37.755697 :B8B5E7AA:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:50:37.755698 :B8B5E7AB:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:50:37.755698 :B8B5E7AC:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:50:37.756207 :B8B5E7AD: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-29 21:51:07.828154 :B8B5F14F:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:51:37.831475 :B8B5FAF1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:51:37.820 2025-07-29 21:51:37.831477 :B8B5FAF2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=17016 pso_num=25 pso_serial#=224 2025-07-29 21:51:37.831622 :B8B5FAF3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=17016 osp_idx=23 osp_ver=221421 osp_pg=0 (spawn #435804) 2025-07-29 21:51:37.831622 :B8B5FAF4: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-29 21:51:37.831623 :B8B5FAF5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=36 time=2506673720 2025-07-29 21:51:37.831623 :B8B5FAF6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:51:37.831623 :B8B5FAF7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:51:37.831624 :B8B5FAF8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:51:37.831624 :B8B5FAF9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:51:37.831625 :B8B5FAFA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:51:37.832143 :B8B5FAFB: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-29 21:52:07.879760 :B8B6058A:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:52:37.932498 :B8B60EF9:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:52:37.933 2025-07-29 21:52:37.932500 :B8B60EFA:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=7572 pso_num=25 pso_serial#=225 2025-07-29 21:52:37.932635 :B8B60EFB:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=7572 osp_idx=23 osp_ver=221422 osp_pg=0 (spawn #435806) 2025-07-29 21:52:37.932635 :B8B60EFC: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-29 21:52:37.932636 :B8B60EFD:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=37 time=2506733814 2025-07-29 21:52:37.932636 :B8B60EFE:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:52:37.932637 :B8B60EFF:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:52:37.932637 :B8B60F00:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:52:37.932637 :B8B60F01:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:52:37.932638 :B8B60F02:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:52:37.933147 :B8B60F03: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-29 21:53:08.007907 :B8B6186C:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:53:38.038583 :B8B62236:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:53:38.027 2025-07-29 21:53:38.038585 :B8B62237:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19252 pso_num=25 pso_serial#=226 2025-07-29 21:53:38.038706 :B8B62238:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19252 osp_idx=23 osp_ver=221423 osp_pg=0 (spawn #435809) 2025-07-29 21:53:38.038707 :B8B62239: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-29 21:53:38.038707 :B8B6223A:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=38 time=2506793923 2025-07-29 21:53:38.038708 :B8B6223B:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:53:38.038708 :B8B6223C:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:53:38.038708 :B8B6223D:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:53:38.038709 :B8B6223E:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:53:38.038709 :B8B6223F:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:53:38.039214 :B8B62240: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-29 21:54:08.139652 :B8B62C38:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:54:38.122549 :B8B635C6:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:54:38.111 2025-07-29 21:54:38.122551 :B8B635C7:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=3292 pso_num=25 pso_serial#=227 2025-07-29 21:54:38.122723 :B8B635C8:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=3292 osp_idx=23 osp_ver=221424 osp_pg=0 (spawn #435811) 2025-07-29 21:54:38.122724 :B8B635C9: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-29 21:54:38.122725 :B8B635CA:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=39 time=2506854017 2025-07-29 21:54:38.122726 :B8B635CB:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:54:38.122726 :B8B635CC:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:54:38.122726 :B8B635CD:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:54:38.122727 :B8B635CE:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:54:38.122727 :B8B635CF:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:54:38.123243 :B8B635D0: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-29 21:55:08.196670 :B8B63F69:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:55:38.200740 :B8B648F4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:55:38.189 2025-07-29 21:55:38.200742 :B8B648F5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=18728 pso_num=25 pso_serial#=228 2025-07-29 21:55:38.200877 :B8B648F6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=18728 osp_idx=23 osp_ver=221425 osp_pg=0 (spawn #435813) 2025-07-29 21:55:38.200878 :B8B648F7: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-29 21:55:38.200879 :B8B648F8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=40 time=2506914095 2025-07-29 21:55:38.200879 :B8B648F9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:55:38.200879 :B8B648FA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:55:38.200880 :B8B648FB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:55:38.200880 :B8B648FC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:55:38.200880 :B8B648FD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:55:38.201348 :B8B648FE: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-29 21:56:03.227630 :B8B65147: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-29 21:56:33.329561 :B8B65AD1:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:56:38.293881 :B8B65CCB:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:56:38.283 2025-07-29 21:56:38.293883 :B8B65CCC:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11148 pso_num=25 pso_serial#=229 2025-07-29 21:56:38.294000 :B8B65CCD:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11148 osp_idx=23 osp_ver=221426 osp_pg=0 (spawn #435815) 2025-07-29 21:56:38.294001 :B8B65CCE: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-29 21:56:38.294001 :B8B65CCF:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=41 time=2506974189 2025-07-29 21:56:38.294002 :B8B65CD0:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:56:38.294002 :B8B65CD1:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:56:38.294002 :B8B65CD2:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:56:38.294002 :B8B65CD3:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:56:38.294003 :B8B65CD4:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:56:38.294494 :B8B65CD5: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-29 21:57:08.376310 :B8B666B2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:57:38.393439 :B8B67071:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:57:38.382 2025-07-29 21:57:38.393441 :B8B67072:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19224 pso_num=25 pso_serial#=230 2025-07-29 21:57:38.393574 :B8B67073:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19224 osp_idx=23 osp_ver=221427 osp_pg=0 (spawn #435817) 2025-07-29 21:57:38.393575 :B8B67074: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-29 21:57:38.393575 :B8B67075:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=42 time=2507034283 2025-07-29 21:57:38.393576 :B8B67076:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:57:38.393576 :B8B67077:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:57:38.393576 :B8B67078:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:57:38.393577 :B8B67079:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:57:38.393577 :B8B6707A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:57:38.394067 :B8B6707B: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-29 21:58:08.487650 :B8B67A1E:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:58:38.455700 :B8B683B2:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:58:38.445 2025-07-29 21:58:38.455702 :B8B683B3:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=11816 pso_num=25 pso_serial#=231 2025-07-29 21:58:38.455847 :B8B683B4:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=11816 osp_idx=23 osp_ver=221428 osp_pg=0 (spawn #435819) 2025-07-29 21:58:38.455847 :B8B683B5: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-29 21:58:38.455848 :B8B683B6:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=43 time=2507094345 2025-07-29 21:58:38.455848 :B8B683B7:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:58:38.455849 :B8B683B8:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:58:38.455849 :B8B683B9:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:58:38.455849 :B8B683BA:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:58:38.455850 :B8B683BB:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:58:38.456331 :B8B683BC: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-29 21:59:08.514175 :B8B68E56:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-07-29 21:59:38.542571 :B8B697E7:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 07-29 21:59:38.531 2025-07-29 21:59:38.542574 :B8B697E8:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19116 pso_num=25 pso_serial#=232 2025-07-29 21:59:38.542695 :B8B697E9:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19116 osp_idx=23 osp_ver=221429 osp_pg=0 (spawn #435821) 2025-07-29 21:59:38.542696 :B8B697EA: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-29 21:59:38.542696 :B8B697EB:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=44 time=2507154423 2025-07-29 21:59:38.542697 :B8B697EC:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-07-29 21:59:38.542697 :B8B697ED:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-07-29 21:59:38.542698 :B8B697EE:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-07-29 21:59:38.542698 :B8B697EF:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-07-29 21:59:38.542699 :B8B697F0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-07-29 21:59:38.543184 :B8B697F1: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-29 22:00:02.036838 :B8B6A0D1: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-29 22:00:02.036838*:B8B6A0F9:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BEC718 estart=1753797601 eid=16785105 ctx=0x000000077FD6A000 cwh=0x0000000026BE0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-29 22:00:02.036838*:B8B6A0FA:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 pubTabIdxCnt=0 2025-07-29 22:00:02.036838*:B8B6A0FB:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BEC718 2025-07-29 22:00:02.036838*:B8B6A0FC:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BEC718 2025-07-29 22:00:02.036838*:B8B6A112:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 xsc->flg4=65792 flags=2 2025-07-29 22:00:02.036838*:B8B6A113:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BEC718 2025-07-29 22:00:02.043765 :B8B6A114: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-29 22:00:02.043833 :B8B6A117:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-07-29 22:00:02.055619 :B8B6A1A3: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-29 22:00:02.061421 :B8B6A2E5: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-29 22:00:02.062234 :B8B6A2ED: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-29 22:00:02.068120 :B8B6A2FE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-07-29 22:00:02.067047 :B8B6A313:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=59 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-07-29 22:00:02.067365 :B8B6A32C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=27 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-07-29 22:00:02.067376 :B8B6A32E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=27 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-07-29 22:00:02.067384 :B8B6A330:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=27 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-29 22:00:02.067441 :B8B6A339:db_trace:ksl2.c@12699:ksliwat(): [10005:25:201] KSL POST RCVD poster=27 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-07-29 22:00:02.067466 :B8B6A33B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=27 loc='kcb2.h LINE:3844 ID:kcbzww' id1=0 id2=0 name= type=0 2025-07-29 22:00:02.067959 :B8B6A33D: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-29 22:00:02.068173 :B8B6A34E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-07-29 22:00:02.069943 :B8B6A35C: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-29 22:00:02.070000 :B8B6A35F: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-29 22:00:02.070100 :B8B6A36D: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-29 22:00:02.160534 :B8B6A4A9: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-29 22:00:02.162721 :B8B6A4B4: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-29 22:00:02.162750 :B8B6A4B9:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-07-29 22:00:02.165203 :B8B6A4C7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-07-29 22:00:02.165865 :B8B6A4C8: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-29 22:00:02.168903 :B8B6A4D0: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-29 22:00:02.168996 :B8B6A4D3: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-29 22:00:02.169083 :B8B6A4E0: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-29 22:00:04.004288 :B8B6A977: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-29 22:00:04.004288*:B8B6A97B:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BEC718 estart=1753797603 eid=16785110 ctx=0x000000077FD6A000 cwh=0x0000000026BE0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-07-29 22:00:04.004288*:B8B6A97C:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 pubTabIdxCnt=0 2025-07-29 22:00:04.004288*:B8B6A97D:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BEC718 2025-07-29 22:00:04.004288*:B8B6A97E:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BEC718 2025-07-29 22:00:04.004288*:B8B6A97F:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 xsc->flg4=65792 flags=2 2025-07-29 22:00:04.004288*:B8B6A980:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BEC718 2025-07-29 22:00:04.006428 :B8B6A981: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-29 22:00:04.006470 :B8B6A984:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-07-29 22:00:04.015302 :B8B6A98A: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-29 22:00:04.016103 :B8B6A992: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-29 22:00:04.016855 :B8B6A99A: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-29 22:00:04.017060 :B8B6A9A2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-07-29 22:00:04.020492 :B8B6A9A3: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-29 22:00:04.020559 :B8B6A9A6: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-29 22:00:04.020651 :B8B6A9B3: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 25 (osid: 19116, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de