Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250614060008\orcl_j002_16004_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250614060008\orcl_j002_16004_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:36658M/63366M, Ph+PgF:43106M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 27 Windows thread id: 16004, image: ORACLE.EXE (J002) *** 2025-06-14 06:00:08.759 *** SESSION ID:(219.60149) 2025-06-14 06:00:08.759 *** 2025-06-14 06:00:08.759 Process diagnostic dump for ORACLE.EXE (J002), OS id=16004, pid: 27, proc_ser: 65, sid: 219, sess_ser: 60149 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 16004 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J002) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12587, hash value=2519366342 Current Wait Stack: Not in wait; last wait ended 1.121719 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 1.121744 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x5, fileno=0x0, filetype=0x3 wait_id=128 seq_num=129 snap_id=1 wait times: snap=0.000209 sec, exc=0.000209 sec, total=0.000209 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 1: waited for 'log file sequential read' log#=0x285f, block#=0x0, blocks=0x0 wait_id=127 seq_num=128 snap_id=1 wait times: snap=0.000004 sec, exc=0.000004 sec, total=0.000004 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.091127 sec of elapsed time 2: waited for 'log file sequential read' log#=0x285f, block#=0x0, blocks=0x0 wait_id=126 seq_num=127 snap_id=1 wait times: snap=0.000027 sec, exc=0.000027 sec, total=0.000027 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.534945 sec of elapsed time 3: waited for 'log file sequential read' log#=0x0, block#=0xc000, blocks=0x800 wait_id=125 seq_num=126 snap_id=1 wait times: snap=0.000329 sec, exc=0.000329 sec, total=0.000329 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.049707 sec of elapsed time 4: waited for 'log file sequential read' log#=0x285f, block#=0x800, blocks=0x800 wait_id=124 seq_num=125 snap_id=1 wait times: snap=0.000205 sec, exc=0.000205 sec, total=0.000205 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.002859 sec of elapsed time 5: waited for 'log file sequential read' log#=0x285f, block#=0x0, blocks=0x0 wait_id=123 seq_num=124 snap_id=1 wait times: snap=0.000002 sec, exc=0.000002 sec, total=0.000002 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000129 sec of elapsed time 6: waited for 'log file sequential read' log#=0x285f, block#=0x2, blocks=0x7fe wait_id=122 seq_num=123 snap_id=1 wait times: snap=0.000194 sec, exc=0.000194 sec, total=0.000194 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000156 sec of elapsed time 7: waited for 'log file sequential read' log#=0x0, block#=0x1, blocks=0x1 wait_id=121 seq_num=122 snap_id=1 wait times: snap=0.000044 sec, exc=0.000044 sec, total=0.000044 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000002 sec of elapsed time 8: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0x0, filetype=0x3 wait_id=120 seq_num=121 snap_id=1 wait times: snap=0.000195 sec, exc=0.000195 sec, total=0.000195 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000119 sec of elapsed time 9: waited for 'control file sequential read' file#=0x0, block#=0x20, blocks=0x1 wait_id=119 seq_num=120 snap_id=1 wait times: snap=0.000049 sec, exc=0.000049 sec, total=0.000049 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000006 sec of elapsed time Sampled Session History of session 219 serial 60149 --------------------------------------------------- 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 --------------------------------------------------- [7 samples, 06:00:01 - 06:00:07] not in wait at each sample [1 sample, 06:00:00] idle wait at each sample [session created at: 06:00:01] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-14 06:00:08.759 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 27 (osid: 16004, J002) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-14 01:59:50.227179 :A45F360B:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 01:59:50.227970 :A45F360C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 01:59:50.236640 :A45F360F:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 01:59:50.221 2025-06-14 01:59:50.236642 :A45F3610:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15472 pso_num=27 pso_serial#=54 2025-06-14 01:59:50.236778 :A45F3611:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15472 (legacy spawn) 2025-06-14 01:59:50.243239 :A45F3612:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 01:59:50.243403 :A45F361B:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 01:59:50.244194 :A45F361C:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 01:59:53.394885 :A45F370D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 01:59:53.382 2025-06-14 01:59:53.394887 :A45F370E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15764 pso_num=27 pso_serial#=55 2025-06-14 01:59:53.395026 :A45F370F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15764 (legacy spawn) 2025-06-14 01:59:53.401567 :A45F3710:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 01:59:53.401735 :A45F3719:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 01:59:53.402527 :A45F371A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 01:59:53.411169 :A45F371D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 01:59:53.398 2025-06-14 01:59:53.411171 :A45F371E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=15280 pso_num=27 pso_serial#=56 2025-06-14 01:59:53.411315 :A45F371F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=15280 (legacy spawn) 2025-06-14 01:59:53.417816 :A45F3720:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 01:59:53.417980 :A45F3729:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 01:59:53.418785 :A45F372A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 03:34:59.178731 :A466B45D:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 03:34:59.166 2025-06-14 03:34:59.178733 :A466B45E:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16076 pso_num=27 pso_serial#=57 2025-06-14 03:34:59.178869 :A466B45F:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16076 (legacy spawn) 2025-06-14 03:34:59.185452 :A466B460:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 03:34:59.185629 :A466B465:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 03:34:59.186469 :A466B46A:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 03:35:00.680027 :A466B4A6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 03:35:00.666 2025-06-14 03:35:00.680029 :A466B4A7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16572 pso_num=27 pso_serial#=58 2025-06-14 03:35:00.680167 :A466B4A8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16572 (legacy spawn) 2025-06-14 03:35:00.686607 :A466B4A9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 03:35:00.686783 :A466B4AE:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 03:35:00.687566 :A466B4B3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 03:35:00.705150 :A466B4B6:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 03:35:00.697 2025-06-14 03:35:00.705152 :A466B4B7:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=11480 pso_num=27 pso_serial#=59 2025-06-14 03:35:00.705321 :A466B4B8:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=11480 (legacy spawn) 2025-06-14 03:35:00.711770 :A466B4B9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 03:35:00.711946 :A466B4C1:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 03:35:00.712792 :A466B4C3:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 03:35:03.523138 :A466B5A8:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 03:35:03.514 2025-06-14 03:35:03.523140 :A466B5A9:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16836 pso_num=27 pso_serial#=60 2025-06-14 03:35:03.523279 :A466B5AA:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16836 (legacy spawn) 2025-06-14 03:35:03.529758 :A466B5AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 03:35:03.529935 :A466B5B0:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 03:35:03.530728 :A466B5B5:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 03:35:03.746134 :A466B5B9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 03:35:03.732 2025-06-14 03:35:03.746136 :A466B5BA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16532 pso_num=27 pso_serial#=61 2025-06-14 03:35:03.746270 :A466B5BB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16532 (legacy spawn) 2025-06-14 03:35:03.752676 :A466B5BC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 03:35:03.752838 :A466B5C5:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 03:35:03.753614 :A466B5C6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 03:35:03.762258 :A466B5C9:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 03:35:03.748 2025-06-14 03:35:03.762259 :A466B5CA:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16924 pso_num=27 pso_serial#=62 2025-06-14 03:35:03.762394 :A466B5CB:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16924 (legacy spawn) 2025-06-14 03:35:03.768946 :A466B5CC:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 03:35:03.769114 :A466B5D5:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 03:35:03.770007 :A466B5D6:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 06:00:00.042035 :A472133E:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 06:00:00.033 2025-06-14 06:00:00.042038 :A472133F:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=14984 pso_num=27 pso_serial#=63 2025-06-14 06:00:00.042177 :A4721340:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=14984 osp_idx=25 osp_ver=62792 osp_pg=0 (spawn #283592) 2025-06-14 06:00:00.042178 :A4721341:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=3704 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 06:00:00.042178 :A4721342:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=49 time=2856543235 2025-06-14 06:00:00.042179 :A4721343:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 06:00:00.042179 :A4721344:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 06:00:00.042179 :A4721345:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 06:00:00.042180 :A4721346:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 06:00:00.042180 :A4721347:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 06:00:00.042713 :A4721348:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.042755 :A472134F:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksv2.h LINE:1639 ID:ksvpst: run' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-14 06:00:00.042830 :A4721362:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.046723 :A4721371:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.047894 :A4721379:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.047920 :A472137C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.047958 :A4721387:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-14 06:00:00.049899 :A4721392:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.049930 :A4721395:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.049978 :A47213A0:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-14 06:00:00.050459 :A47213AB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.052931 :A47213B3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.058357 :A47213BB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.063317 :A47213C3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.064283 :A47213CB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.065793 :A47213D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.068783 :A47213DB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.070085 :A47213E3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.073000 :A47213EB:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.076867 :A47213F3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.077267 :A4721402:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.077318 :A4721405:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-06-14 06:00:00.077332 :A4721406:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-06-14 06:00:00.080109 :A472140C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.080394 :A472141B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.080441 :A472141E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-06-14 06:00:00.080460 :A472141F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-06-14 06:00:00.083190 :A4721425:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.083493 :A4721434:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.083539 :A4721437:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:ktcc.c:879 2025-06-14 06:00:00.083552 :A4721438:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:ktcc.c:879 2025-06-14 06:00:00.083729 :A472143E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.083740 :A4721441:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=18 loc='ksr2.h LINE:603 ID:ksrpublish' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.083767 :A472144C:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] KSL POST RCVD poster=18 loc='ksr2.h LINE:607 ID:ksrmdone' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-06-14 06:00:00.085302 :A4721457:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 06:00:00.953465 :A4721479:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 06:00:00.939 2025-06-14 06:00:00.953467 :A472147A:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16624 pso_num=27 pso_serial#=64 2025-06-14 06:00:00.953606 :A472147B:db_trace:kso.c@4070:ksonfy(): [10420:27:0] kso: new process: pid=16624 (legacy spawn) 2025-06-14 06:00:00.960160 :A472147C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:00.960335 :A4721484:db_trace:ksl2.c@12699:ksliwat(): [10005:27:219] 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-06-14 06:00:00.961162 :A4721486:db_trace:kst.c@698:kstpsodel(): [10280:27:0] kst: process state object about to be deleted 2025-06-14 06:00:01.528510 :A47214E7:db_trace:kst.c@673:kstipg(): [10280:27:0] kst: process state object created on 06-14 06:00:01.522 2025-06-14 06:00:01.528511 :A47214E8:db_trace:kst.c@679:kstipg(): [10280:27:0] kst: process info: ospid=16004 pso_num=27 pso_serial#=65 2025-06-14 06:00:01.528661 :A47214E9:db_trace:kso.c@4093:ksonfy(): [10420:27:0] kso: new process: pid=16004 osp_idx=25 osp_ver=62794 osp_pg=0 (spawn #283593) 2025-06-14 06:00:01.528661 :A47214EA:db_trace:kso.c@4099:ksonfy(): [10420:27:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 06:00:01.528662 :A47214EB:db_trace:kso.c@4103:ksonfy(): [10420:27:0] kso: new process: pso_index=27 reservation=50 time=2856544719 2025-06-14 06:00:01.528662 :A47214EC:db_trace:kso.c@4109:ksonfy(): [10420:27:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 06:00:01.528663 :A47214ED:db_trace:kso.c@4111:ksonfy(): [10420:27:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 06:00:01.528663 :A47214EE:db_trace:kso.c@4113:ksonfy(): [10420:27:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 06:00:01.528664 :A47214EF:db_trace:kso.c@4115:ksonfy(): [10420:27:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 06:00:01.528664 :A47214F0:db_trace:kso.c@4117:ksonfy(): [10420:27:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 06:00:01.529236 :A47214F9:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.534312 :A472151F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.534357 :A4721522:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:jslv.c:9203 2025-06-14 06:00:01.551615 :A4721711:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.551835 :A4721719:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.552015 :A4721721:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.552205 :A4721729:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.552383 :A4721731:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.552547 :A4721739:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.552703 :A4721741:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.552860 :A4721749:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.553022 :A4721751:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.553175 :A4721759:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.553559 :A4721761:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.553781 :A4721769:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.554081 :A4721771:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.554237 :A4721779:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.554398 :A4721781:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.554557 :A4721789:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.554711 :A472179E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.554860 :A47217B0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.555030 :A47217B8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.555196 :A47217C0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.555404 :A47217C8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.555538 :A47217D3:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='kcrf.h LINE:3299 ID:kcrfw_redo_gen: wake LGWR after redo copy' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.555561 :A47217D5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.555712 :A47217E8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.555914 :A47217F0:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.556125 :A47217F8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.556280 :A4721800:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:01.583129 :A4721817:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:02.787925*:A4721A40:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029A73AD0 estart=1749852002 eid=19353123 ctx=0x0000000777968158 cwh=0x00000000449D0158 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-06-14 06:00:02.787925*:A4721A41:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029A73AD0 curCtx=0x00000000448D1BF8 pubTabIdxCnt=0 2025-06-14 06:00:02.787925*:A4721A42:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029A73AD0 2025-06-14 06:00:02.787925*:A4721A43:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029A73AD0 2025-06-14 06:00:02.787925*:A4721A44:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029AEB6F0 estart=1749852000 eid=16777386 ctx=0x000000077B54EAC8 cwh=0x0000000029AE0068 cpu=1015625 buffg=54199 interb=196608 r=24 rb=196608 w=0 wb=0 2025-06-14 06:00:02.787925*:A4721A45:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029AEB6F0 curCtx=0x00000000448C7FD8 pubTabIdxCnt=0 2025-06-14 06:00:02.787925*:A4721A46:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029AEB6F0 2025-06-14 06:00:02.787925*:A4721A47:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029AEB6F0 2025-06-14 06:00:02.787925*:A4721A48:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029A73AD0 curCtx=0x00000000448D1BF8 xsc->flg4=65792 flags=1 2025-06-14 06:00:02.787925*:A4721A49:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029A73AD0 2025-06-14 06:00:03.287941*:A4721B91:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029AEB6F0 curCtx=0x00000000448C7FD8 xsc->flg4=65792 flags=2 2025-06-14 06:00:03.287941*:A4721B92:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029AEB6F0 2025-06-14 06:00:03.301230 :A4721B93:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:03.320961 :A4721B9B:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:03.322894 :A4721BA3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpus:psdpgi.c:2235 2025-06-14 06:00:03.323110 :A4721BA4:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:27:219] atxpop:psdpgi.c:2235 2025-06-14 06:00:03.323998 :A4721BA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:03.324091 :A4721BA8:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:03.324916 :A4721BBA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:03.326467 :A4721BC2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:03.326751 :A4721BCA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:03.381687*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-06-14 06:00:03.381687*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-06-14 06:00:03.381687*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-06-14 06:00:03.428564*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-06-14 06:00:03.428564*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-06-14 06:00:03.428564*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-06-14 06:00:03.428564*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-06-14 06:00:03.491410 :A4721BD2:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:05.421075 :A4721CF5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:05.421094 :A4721CF6:db_trace:ktur.c@3079:ktuabt(): [10444:27:219] ABORT TRANSACTION - xid: 0x0009.00c.0001ccee 2025-06-14 06:00:08.110723 :A4721EBD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:08.112565 :A4721EC5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:08.124567 :A4721ECD:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-06-14 06:00:08.149261 :A4721ED5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:27:219] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 27 (osid: 16004, J002)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de