Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250803140842\orcl_j001_19120_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250803140842\orcl_j001_19120_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:35781M/63366M, Ph+PgF:41420M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 25 Windows thread id: 19120, image: ORACLE.EXE (J001) *** 2025-08-03 14:08:42.132 *** SESSION ID:(201.40961) 2025-08-03 14:08:42.132 *** 2025-08-03 14:08:42.132 Process diagnostic dump for ORACLE.EXE (J001), OS id=19120, pid: 25, proc_ser: 70, sid: 201, sess_ser: 40961 ------------------------------------------------------------------------------- current sql: <none> client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 19120 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J001) Current Wait Stack: 0: waiting for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=5 seq_num=6 snap_id=1 wait times: snap=0.273565 sec, exc=0.273565 sec, total=0.273565 sec wait times: max=0.500000 sec, heur=2.773644 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.000009 sec since current wait 0: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=4 seq_num=5 snap_id=1 wait times: snap=0.499994 sec, exc=0.499994 sec, total=0.499994 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000008 sec of elapsed time 1: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=3 seq_num=4 snap_id=1 wait times: snap=0.502336 sec, exc=0.502336 sec, total=0.502336 sec wait times: max=0.500000 sec wait counts: calls=1 os=1 occurred after 0.000012 sec of elapsed time 2: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=2 seq_num=3 snap_id=1 wait times: snap=0.499997 sec, exc=0.499997 sec, total=0.499997 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=1 seq_num=2 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.000009 sec of elapsed time 4: waited for 'jobq slave wait' =0x0, =0x0, =0x0 wait_id=0 seq_num=1 snap_id=1 wait times: snap=0.497708 sec, exc=0.497708 sec, total=0.497708 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 201 serial 40961 --------------------------------------------------- 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 --------------------------------------------------- [3 samples, 14:08:39 - 14:08:42] idle wait at each sample [session created at: 14:08:39] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-03 14:08:42.132 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 25 (osid: 19120, J001) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-03 14:00:15.667045 :BACCCF99:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19264 osp_idx=23 osp_ver=226359 osp_pg=0 (spawn #451380) 2025-08-03 14:00:15.667046 :BACCCF9A:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:00:15.667046 :BACCCF9B:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=127 time=2910284970 2025-08-03 14:00:15.667047 :BACCCF9C:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:00:15.667047 :BACCCF9D:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:00:15.667047 :BACCCF9E:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:00:15.667048 :BACCCF9F:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:00:15.667048 :BACCCFA0:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:00:15.667547 :BACCCFA1: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-08-03 14:00:45.785206 :BACCDA4D:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:01:15.750182 :BACCE47F:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:01:15.739 2025-08-03 14:01:15.750184 :BACCE480:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=2156 pso_num=25 pso_serial#=63 2025-08-03 14:01:15.750326 :BACCE481:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=2156 osp_idx=23 osp_ver=226360 osp_pg=0 (spawn #451382) 2025-08-03 14:01:15.750327 :BACCE482:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:01:15.750327 :BACCE483:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=128 time=2910345048 2025-08-03 14:01:15.750327 :BACCE484:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:01:15.750328 :BACCE485:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:01:15.750328 :BACCE486:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:01:15.750328 :BACCE487:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:01:15.750329 :BACCE488:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:01:15.750817 :BACCE489: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-08-03 14:01:45.879051 :BACCEEB2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:02:15.847853 :BACCF87E:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:02:15.837 2025-08-03 14:02:15.847855 :BACCF87F:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20304 pso_num=25 pso_serial#=64 2025-08-03 14:02:15.847993 :BACCF880:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20304 osp_idx=23 osp_ver=226361 osp_pg=0 (spawn #451384) 2025-08-03 14:02:15.847994 :BACCF881:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:02:15.847995 :BACCF882:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=129 time=2910405142 2025-08-03 14:02:15.847995 :BACCF883:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:02:15.847995 :BACCF884:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:02:15.847996 :BACCF885:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:02:15.847996 :BACCF886:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:02:15.847997 :BACCF887:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:02:15.848483 :BACCF888: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-08-03 14:02:45.914882 :BACD0279:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:03:15.939291 :BACD0CA4:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:03:15.928 2025-08-03 14:03:15.939293 :BACD0CA5:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=15432 pso_num=25 pso_serial#=65 2025-08-03 14:03:15.939414 :BACD0CA6:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=15432 osp_idx=23 osp_ver=226362 osp_pg=0 (spawn #451386) 2025-08-03 14:03:15.939414 :BACD0CA7:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:03:15.939415 :BACD0CA8:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=130 time=2910465236 2025-08-03 14:03:15.939415 :BACD0CA9:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:03:15.939416 :BACD0CAA:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:03:15.939417 :BACD0CAB:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:03:15.939417 :BACD0CAC:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:03:15.939417 :BACD0CAD:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:03:15.939888 :BACD0CAE: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-08-03 14:03:46.009102 :BACD1750:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:04:16.025497 :BACD217C:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:04:16.014 2025-08-03 14:04:16.025499 :BACD217D:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20028 pso_num=25 pso_serial#=66 2025-08-03 14:04:16.025635 :BACD217E:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20028 osp_idx=23 osp_ver=226363 osp_pg=0 (spawn #451390) 2025-08-03 14:04:16.025636 :BACD217F:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:04:16.025636 :BACD2180:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=131 time=2910525329 2025-08-03 14:04:16.025637 :BACD2181:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:04:16.025637 :BACD2182:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:04:16.025637 :BACD2183:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:04:16.025638 :BACD2184:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:04:16.025638 :BACD2185:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:04:16.026109 :BACD2186: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-08-03 14:04:46.103901 :BACD2B75:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:05:16.142843 :BACD36A1:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:05:16.131 2025-08-03 14:05:16.142846 :BACD36A2:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20172 pso_num=25 pso_serial#=67 2025-08-03 14:05:16.143032 :BACD36A3:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20172 osp_idx=23 osp_ver=226364 osp_pg=0 (spawn #451392) 2025-08-03 14:05:16.143033 :BACD36A4:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:05:16.143033 :BACD36A5:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=132 time=2910585439 2025-08-03 14:05:16.143034 :BACD36A6:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:05:16.143034 :BACD36A7:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:05:16.143035 :BACD36A8:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:05:16.143035 :BACD36A9:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:05:16.143035 :BACD36AA:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:05:16.143535 :BACD36AB: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-08-03 14:05:31.156283 :BACD40F0: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-08-03 14:06:01.210298 :BACD4AE2:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:06:16.232216 :BACD4FCD:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:06:16.221 2025-08-03 14:06:16.232218 :BACD4FCE:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=20452 pso_num=25 pso_serial#=68 2025-08-03 14:06:16.232339 :BACD4FCF:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=20452 osp_idx=23 osp_ver=226365 osp_pg=0 (spawn #451394) 2025-08-03 14:06:16.232339 :BACD4FD0:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:06:16.232340 :BACD4FD1:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=133 time=2910645533 2025-08-03 14:06:16.232340 :BACD4FD2:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:06:16.232341 :BACD4FD3:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:06:16.232341 :BACD4FD4:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:06:16.232342 :BACD4FD5:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:06:16.232342 :BACD4FD6:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:06:16.232839 :BACD4FD7: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-08-03 14:06:46.311212 :BACD59E3:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:07:16.317429 :BACD6401:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:07:16.306 2025-08-03 14:07:16.317431 :BACD6402:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=12648 pso_num=25 pso_serial#=69 2025-08-03 14:07:16.317554 :BACD6403:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=12648 osp_idx=23 osp_ver=226366 osp_pg=0 (spawn #451396) 2025-08-03 14:07:16.317555 :BACD6404:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:07:16.317555 :BACD6405:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=134 time=2910705611 2025-08-03 14:07:16.317556 :BACD6406:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:07:16.317556 :BACD6407:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:07:16.317556 :BACD6408:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:07:16.317557 :BACD6409:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:07:16.317557 :BACD640A:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:07:16.318028 :BACD640B: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-08-03 14:07:46.415754 :BACD6DFD:db_trace:kst.c@698:kstpsodel(): [10280:25:0] kst: process state object about to be deleted 2025-08-03 14:08:16.398041 :BACD77CF:db_trace:kst.c@673:kstipg(): [10280:25:0] kst: process state object created on 08-03 14:08:16.386 2025-08-03 14:08:16.398043 :BACD77D0:db_trace:kst.c@679:kstipg(): [10280:25:0] kst: process info: ospid=19120 pso_num=25 pso_serial#=70 2025-08-03 14:08:16.398161 :BACD77D1:db_trace:kso.c@4093:ksonfy(): [10420:25:0] kso: new process: pid=19120 osp_idx=23 osp_ver=226367 osp_pg=0 (spawn #451398) 2025-08-03 14:08:16.398162 :BACD77D2:db_trace:kso.c@4099:ksonfy(): [10420:25:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-03 14:08:16.398163 :BACD77D3:db_trace:kso.c@4103:ksonfy(): [10420:25:0] kso: new process: pso_index=25 reservation=135 time=2910765704 2025-08-03 14:08:16.398163 :BACD77D4:db_trace:kso.c@4109:ksonfy(): [10420:25:0] kso: spawn diagnostics: queue time=0 secs 2025-08-03 14:08:16.398164 :BACD77D5:db_trace:kso.c@4111:ksonfy(): [10420:25:0] kso: spawn diagnostics: fork time=0 secs 2025-08-03 14:08:16.398164 :BACD77D6:db_trace:kso.c@4113:ksonfy(): [10420:25:0] kso: spawn diagnostics: exec time=0 secs 2025-08-03 14:08:16.398164 :BACD77D7:db_trace:kso.c@4115:ksonfy(): [10420:25:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-03 14:08:16.398164 :BACD77D8:db_trace:kso.c@4117:ksonfy(): [10420:25:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-03 14:08:16.398696 :BACD77D9: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-08-03 14:08:37.546985 :BACD8103: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-08-03 14:08:37.653860 :BACD8441: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-08-03 14:08:37.653860*:BACD8450:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000026BEC718 estart=1754201317 eid=16785401 ctx=0x000000077FD6A000 cwh=0x0000000026BE0068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-03 14:08:37.653860*:BACD8451:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 pubTabIdxCnt=0 2025-08-03 14:08:37.653860*:BACD8452:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000026BEC718 2025-08-03 14:08:37.653860*:BACD8453:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000026BEC718 2025-08-03 14:08:37.653860*:BACD8456:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000026BEC718 curCtx=0x0000000026BE8938 xsc->flg4=65792 flags=2 2025-08-03 14:08:37.653860*:BACD8457:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000026BEC718 2025-08-03 14:08:37.659226 :BACD8460: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-08-03 14:08:37.659262 :BACD8463:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:jslv.c:9203 2025-08-03 14:08:37.663087 :BACD8473: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-08-03 14:08:37.783160 :BACD847B: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-08-03 14:08:37.912415 :BACD8483: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-08-03 14:08:38.050100 :BACD848B: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-08-03 14:08:39.197282 :BACD84EE: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-08-03 14:08:39.198291 :BACD84F6: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-08-03 14:08:39.199877 :BACD84FE: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-08-03 14:08:39.201332 :BACD8506: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-08-03 14:08:39.202725 :BACD850E: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-08-03 14:08:39.205759 :BACD8516: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-08-03 14:08:39.221789 :BACD851E: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-08-03 14:08:39.222398 :BACD8526: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-08-03 14:08:39.222934 :BACD852E: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-08-03 14:08:39.223442 :BACD8536: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-08-03 14:08:39.226102 :BACD853E: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-08-03 14:08:39.227032 :BACD8546:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.227787 :BACD8547:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.228534 :BACD8548:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.228942 :BACD8549:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.228949 :BACD854A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.229493 :BACD854B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.230075 :BACD854C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.230370 :BACD854D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.231409 :BACD854E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.262371 :BACD8557: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-08-03 14:08:39.262427 :BACD855A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.263314 :BACD8560: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-08-03 14:08:39.264270 :BACD8568:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.264596 :BACD8569:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:25:201] KSL POST SENT postee=16 loc='ktm.h LINE:583 ID:ktmpsm' id1=0 id2=0 name= type=0 2025-08-03 14:08:39.264814 :BACD8576: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-08-03 14:08:39.281724 :BACD85B5: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-08-03 14:08:39.281771 :BACD85B8:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.282549 :BACD85BE: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-08-03 14:08:39.283373 :BACD85C6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.283849 :BACD85C7: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-08-03 14:08:39.303293 :BACD8690: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-08-03 14:08:39.303325 :BACD8691:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.304117 :BACD86C3: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-08-03 14:08:39.315666 :BACD871B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.316262 :BACD871C: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-08-03 14:08:39.316511*:BACD8728:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DC4C068 estart=1754201319 eid=16778654 ctx=0x000000077352A750 cwh=0x000000002DB5BF50 cpu=0 buffg=3 interb=0 r=0 rb=0 w=0 wb=0 2025-08-03 14:08:39.316511*:BACD8729:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DC4C068 curCtx=0x000000002DBAFAD8 pubTabIdxCnt=0 2025-08-03 14:08:39.316511*:BACD872A:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DC4C068 2025-08-03 14:08:39.316511*:BACD872B:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DC4C068 2025-08-03 14:08:39.316511*:BACD872C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x000000002DB5E3E0 estart=1754201318 eid=16778635 ctx=0x000000077B458BE8 cwh=0x0000000026C32E18 cpu=15625 buffg=3 interb=0 r=0 rb=0 w=0 wb=0 2025-08-03 14:08:39.316511*:BACD872D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x000000002DB5E3E0 curCtx=0x000000002DBE65D0 pubTabIdxCnt=0 2025-08-03 14:08:39.316511*:BACD872E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x000000002DB5E3E0 2025-08-03 14:08:39.316511*:BACD872F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x000000002DB5E3E0 2025-08-03 14:08:39.316511*:BACD8730:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DC4C068 curCtx=0x000000002DBAFAD8 xsc->flg4=65792 flags=1 2025-08-03 14:08:39.316511*:BACD8731:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DC4C068 2025-08-03 14:08:39.332154*:BACD8734:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x000000002DB5E3E0 curCtx=0x000000002DBE65D0 xsc->flg4=65792 flags=2 2025-08-03 14:08:39.332154*:BACD8735:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x000000002DB5E3E0 2025-08-03 14:08:39.333300 :BACD8736: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-08-03 14:08:39.333351 :BACD8739:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.334222 :BACD873F: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-08-03 14:08:39.335115 :BACD8747:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpus:psdpgi.c:2235 2025-08-03 14:08:39.335552 :BACD8748: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-08-03 14:08:39.356689 :BACD8750: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-08-03 14:08:39.356739 :BACD8753:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:psdpgi.c:2235 2025-08-03 14:08:39.357632 :BACD8759: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-08-03 14:08:39.358109 :BACD8761: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-08-03 14:08:39.358471 :BACD8769: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-08-03 14:08:39.358650 :BACD8771: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-08-03 14:08:39.358780 :BACD8779: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-08-03 14:08:39.358921 :BACD8781:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:25:201] atxpop:jslv.c:9203 2025-08-03 14:08:39.362977 :BACD8782: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-08-03 14:08:39.363055 :BACD8785: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-08-03 14:08:39.363149 :BACD8792: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: 19120, J001)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de