Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250810140856\orcl_j000_17204_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250810140856\orcl_j000_17204_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:35600M/63366M, Ph+PgF:41074M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 17204, image: ORACLE.EXE (J000) *** 2025-08-10 14:08:56.430 *** SESSION ID:(193.55959) 2025-08-10 14:08:56.430 *** 2025-08-10 14:08:56.430 Process diagnostic dump for ORACLE.EXE (J000), OS id=17204, pid: 24, proc_ser: 216, sid: 193, sess_ser: 55959 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 17204 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12899, hash value=3212746507 Current Wait Stack: Not in wait; last wait ended 2.177045 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 2.177070 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x2, fileno=0xc9, filetype=0x2 wait_id=83 seq_num=84 snap_id=1 wait times: snap=0.000146 sec, exc=0.000146 sec, total=0.000146 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.051390 sec of elapsed time 1: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=82 seq_num=83 snap_id=1 wait times: snap=0.000004 sec, exc=0.000004 sec, total=0.000004 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.763786 sec of elapsed time 2: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=81 seq_num=82 snap_id=1 wait times: snap=0.000006 sec, exc=0.000006 sec, total=0.000006 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.026639 sec of elapsed time 3: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=80 seq_num=81 snap_id=1 wait times: snap=0.000005 sec, exc=0.000005 sec, total=0.000005 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.012747 sec of elapsed time 4: waited for 'db file sequential read' file#=0x2, block#=0x78fa, blocks=0x1 wait_id=79 seq_num=80 snap_id=1 wait times: snap=0.000115 sec, exc=0.000115 sec, total=0.000115 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.049799 sec of elapsed time 5: waited for 'db file sequential read' file#=0x2, block#=0x1e5a, blocks=0x1 wait_id=78 seq_num=79 snap_id=1 wait times: snap=0.019249 sec, exc=0.019249 sec, total=0.019249 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.007893 sec of elapsed time 6: waited for 'db file sequential read' file#=0x1, block#=0x2d00, blocks=0x1 wait_id=77 seq_num=78 snap_id=1 wait times: snap=0.000119 sec, exc=0.000119 sec, total=0.000119 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.262859 sec of elapsed time 7: waited for 'db file sequential read' file#=0x1, block#=0x130, blocks=0x1 wait_id=76 seq_num=77 snap_id=1 wait times: snap=0.004463 sec, exc=0.004463 sec, total=0.004463 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000211 sec of elapsed time 8: waited for 'db file sequential read' file#=0x1, block#=0xc8, blocks=0x1 wait_id=75 seq_num=76 snap_id=1 wait times: snap=0.000132 sec, exc=0.000132 sec, total=0.000132 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.007808 sec of elapsed time 9: waited for 'asynch descriptor resize' outstanding #aio=0x0, current aio limit=0xffffffff, new aio limit=0x82 wait_id=74 seq_num=75 snap_id=1 wait times: snap=0.000001 sec, exc=0.000001 sec, total=0.000001 sec wait times: max=307445734561 min 49 sec wait counts: calls=0 os=0 occurred after 0.000049 sec of elapsed time Sampled Session History of session 193 serial 55959 --------------------------------------------------- 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 --------------------------------------------------- [4 samples, 14:08:53 - 14:08:56] not in wait at each sample [22 samples, 14:08:30 - 14:08:52] idle wait at each sample [session created at: 14:08:30] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-08-10 14:08:56.430 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 17204, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-08-10 14:06:30.364297 :BDE38022:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.364809 :BDE38023:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.364842 :BDE38024:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.364955 :BDE38025:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.364984 :BDE38026:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.365076 :BDE38027:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.365104 :BDE38028:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.365202 :BDE38029:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.365230 :BDE3802A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.365332 :BDE3802B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.365359 :BDE3802C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.365402 :BDE3802D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.365648 :BDE3802E:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:06:30.365688 :BDE38031:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.372383 :BDE38037:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:06:30.372446 :BDE3803A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-08-10 14:06:30.372477 :BDE3803B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-08-10 14:06:30.374282 :BDE38041:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.374326 :BDE38042:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.377794 :BDE38043:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.378086 :BDE38044:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:06:30.378128 :BDE38047:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.383245 :BDE3804D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:06:30.383316 :BDE38050:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-08-10 14:06:30.383347 :BDE38051:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-08-10 14:06:30.383678 :BDE38057:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-10 14:06:30.384041 :BDE38058:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-10 14:06:30.384173 :BDE38059:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.384428 :BDE3805A:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:06:30.384457 :BDE3805D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.386098 :BDE38063:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:06:30.386331 :BDE38064:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:06:30.386360 :BDE38067:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:06:30.387332 :BDE3806D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:06:30.387457 :BDE38076:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:07:00.482192 :BDE389ED:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:07:18.206296 :BDE38F39:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:07:18.193 2025-08-10 14:07:18.206298 :BDE38F3A:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21056 pso_num=24 pso_serial#=208 2025-08-10 14:07:18.206462 :BDE38F3B:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=21056 (legacy spawn) 2025-08-10 14:07:18.213505 :BDE38F3C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:18.213699 :BDE38F41:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:07:18.214671 :BDE38F46:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:07:19.457483 :BDE38FA3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:07:19.443 2025-08-10 14:07:19.457486 :BDE38FA4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12636 pso_num=24 pso_serial#=209 2025-08-10 14:07:19.457631 :BDE38FA5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12636 (legacy spawn) 2025-08-10 14:07:19.464141 :BDE38FA6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:19.464311 :BDE38FAB:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:07:19.465163 :BDE38FB0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:07:19.474001 :BDE38FB3:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:07:19.474 2025-08-10 14:07:19.474003 :BDE38FB4:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=20260 pso_num=24 pso_serial#=210 2025-08-10 14:07:19.474141 :BDE38FB5:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=20260 (legacy spawn) 2025-08-10 14:07:19.480612 :BDE38FB6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:19.480779 :BDE38FBF:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:07:19.481599 :BDE38FC0:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:07:22.586214 :BDE390B7:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:07:22.573 2025-08-10 14:07:22.586216 :BDE390B8:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13660 pso_num=24 pso_serial#=211 2025-08-10 14:07:22.586348 :BDE390B9:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13660 (legacy spawn) 2025-08-10 14:07:22.592967 :BDE390BA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:22.593143 :BDE390BF:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:07:22.594018 :BDE390C4:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:07:22.612808 :BDE390C7:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:07:22.604 2025-08-10 14:07:22.612811 :BDE390C8:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=9912 pso_num=24 pso_serial#=212 2025-08-10 14:07:22.612951 :BDE390C9:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=9912 (legacy spawn) 2025-08-10 14:07:22.619527 :BDE390CA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:22.619696 :BDE390D3:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:07:22.620663 :BDE390D4:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:07:28.429986 :BDE392A1:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:07:28.420 2025-08-10 14:07:28.429988 :BDE392A2:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=20692 pso_num=24 pso_serial#=213 2025-08-10 14:07:28.430137 :BDE392A3:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=20692 (legacy spawn) 2025-08-10 14:07:28.437355 :BDE392A4:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:28.437546 :BDE392A9:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:07:28.438455 :BDE392AE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:07:30.381893 :BDE3934D:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:07:30.376 2025-08-10 14:07:30.381896 :BDE3934E:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=21356 pso_num=24 pso_serial#=214 2025-08-10 14:07:30.382042 :BDE3934F:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=21356 osp_idx=22 osp_ver=704534 osp_pg=0 (spawn #474737) 2025-08-10 14:07:30.382042 :BDE39350:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 14:07:30.382043 :BDE39351:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=138 time=3515519689 2025-08-10 14:07:30.382043 :BDE39352:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 14:07:30.382044 :BDE39353:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 14:07:30.382044 :BDE39354:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 14:07:30.382044 :BDE39355:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 14:07:30.382045 :BDE39356:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 14:07:30.382579 :BDE39357:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-10 14:07:30.383351 :BDE3936C:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:30.391333 :BDE39388:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:07:30.391780 :BDE39389:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:30.391816 :BDE3938C:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:07:30.392884 :BDE39392:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:07:30.393049 :BDE39399:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:08:00.505861 :BDE39D18:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:08:02.515050 :BDE39DC4:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:08:02.500 2025-08-10 14:08:02.515052 :BDE39DC5:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=19228 pso_num=24 pso_serial#=215 2025-08-10 14:08:02.515195 :BDE39DC6:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=19228 (legacy spawn) 2025-08-10 14:08:02.522031 :BDE39DC7:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:02.522065 :BDE39DCA:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:02.522237 :BDE39DD1:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:08:02.523086 :BDE39DDE:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-08-10 14:08:30.468400 :BDE3A628:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 08-10 14:08:30.463 2025-08-10 14:08:30.468402 :BDE3A629:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17204 pso_num=24 pso_serial#=216 2025-08-10 14:08:30.468545 :BDE3A62A:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=17204 osp_idx=22 osp_ver=704536 osp_pg=0 (spawn #474739) 2025-08-10 14:08:30.468546 :BDE3A62B:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-08-10 14:08:30.468546 :BDE3A62C:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=139 time=3515579767 2025-08-10 14:08:30.468547 :BDE3A62D:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-08-10 14:08:30.468547 :BDE3A62E:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-08-10 14:08:30.468548 :BDE3A62F:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-08-10 14:08:30.468548 :BDE3A630:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-08-10 14:08:30.468548 :BDE3A631:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-08-10 14:08:30.469045 :BDE3A632:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=59 loc='kso2.h LINE:416 ID:ksoreq_reply' id1=0 id2=0 name= type=0 2025-08-10 14:08:30.469696 :BDE3A647:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:30.480735 :BDE3A663:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-10 14:08:30.481204 :BDE3A664:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-08-10 14:08:30.483556 :BDE3A665:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:08:30.483900 :BDE3A666:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:30.483937 :BDE3A669:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:08:30.484812 :BDE3A66F:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:30.484944 :BDE3A678:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=14 loc='ksl2.h LINE:2165 ID:kslpsr' id1=134 id2=0 name=EV type=0 fac#=0 facpost=1 2025-08-10 14:08:52.449484 :BDE3AEC9:db_trace:ksl2.c@12699:ksliwat(): [10005:24:193] KSL POST RCVD poster=59 loc='kkj.h LINE:914 ID:kkjpstnp' id1=0 id2=0 name= type=0 fac#=0 facpost=1 2025-08-10 14:08:52.449484*:BDE3AECB:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1754806131 eid=16785830 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-08-10 14:08:52.449484*:BDE3AECC:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-08-10 14:08:52.449484*:BDE3AECD:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-08-10 14:08:52.449484*:BDE3AECE:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-08-10 14:08:52.449484*:BDE3AED7:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-08-10 14:08:52.449484*:BDE3AED8:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-08-10 14:08:52.451455 :BDE3AEF6:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.451475 :BDE3AEFE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-08-10 14:08:52.471053 :BDE3AF0D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.471273 :BDE3AF15:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.471432 :BDE3AF1D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.471612 :BDE3AF25:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.471773 :BDE3AF2D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.471933 :BDE3AF35:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.472087 :BDE3AF3D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.472230 :BDE3AF45:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.472375 :BDE3AF4D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.472516 :BDE3AF55:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.472661 :BDE3AF5D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.472798 :BDE3AF65:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.472950 :BDE3AF6D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.473180 :BDE3AF75:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.473321 :BDE3AF7D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.473654 :BDE3AF85:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.473913 :BDE3AF8D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.474097 :BDE3AF95:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.474315 :BDE3AF9D:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:52.492813 :BDE3AFA5:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:53.966938*:BDE3B05C:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000027193AD0 estart=1754806133 eid=21276666 ctx=0x0000000777968158 cwh=0x00000000299B0068 cpu=0 buffg=2 interb=0 r=0 rb=0 w=0 wb=0 2025-08-10 14:08:53.966938*:BDE3B05D:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000027193AD0 curCtx=0x0000000029A719A8 pubTabIdxCnt=0 2025-08-10 14:08:53.966938*:BDE3B05E:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000027193AD0 2025-08-10 14:08:53.966938*:BDE3B05F:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000027193AD0 2025-08-10 14:08:53.966938*:BDE3B060:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x00000000271FB820 estart=1754806131 eid=16777513 ctx=0x000000077B54EAC8 cwh=0x0000000024D80608 cpu=1265625 buffg=69541 interb=196608 r=24 rb=196608 w=0 wb=0 2025-08-10 14:08:53.966938*:BDE3B061:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x00000000271FB820 curCtx=0x0000000029A79FF0 pubTabIdxCnt=0 2025-08-10 14:08:53.966938*:BDE3B062:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x00000000271FB820 2025-08-10 14:08:53.966938*:BDE3B063:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x00000000271FB820 2025-08-10 14:08:53.966938*:BDE3B064:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000027193AD0 curCtx=0x0000000029A719A8 xsc->flg4=65792 flags=1 2025-08-10 14:08:53.966938*:BDE3B065:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000027193AD0 2025-08-10 14:08:54.180156*:BDE3B115:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x00000000271FB820 curCtx=0x0000000029A79FF0 xsc->flg4=65792 flags=2 2025-08-10 14:08:54.180156*:BDE3B116:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x00000000271FB820 2025-08-10 14:08:54.184040 :BDE3B117:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:54.204258 :BDE3B139:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:54.206157 :BDE3B141:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-08-10 14:08:54.206347 :BDE3B142:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-08-10 14:08:54.207244 :BDE3B143:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:54.207333 :BDE3B146:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:54.208277 :BDE3B158:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:54.209731 :BDE3B160:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:54.210004 :BDE3B168:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:54.258293*:SQL_Analyze:qksan.c@3402:qksanAnalyzeSql(begin): qksanAnalyzeSql(enter): goal=15 options=16778048 pgadep=0 binds#=0 byPos=0 timeLim=0 timeFired=0 2025-08-10 14:08:54.258293*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-08-10 14:08:54.258293*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-08-10 14:08:54.258293*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-08-10 14:08:54.258293*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-08-10 14:08:54.258293*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-08-10 14:08:54.258293*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-08-10 14:08:54.333781 :BDE3B1DE:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:56.222720 :BDE3B268:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] KSL POST SENT postee=14 loc='ksa2.h LINE:282 ID:ksasnd' id1=0 id2=0 name= type=0 2025-08-10 14:08:56.222736 :BDE3B269:db_trace:ktur.c@3079:ktuabt(): [10444:24:193] ABORT TRANSACTION - xid: 0x000a.00b.001772fc ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 17204, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de