Edit D:\app\Administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250614220630\orcl_j000_4856_bucket.trc
Trace file d:\app\administrator\diag\rdbms\orcl\orcl\trace\cdmp_20250614220630\orcl_j000_4856_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:36653M/63366M, Ph+PgF:43101M/72582M Instance name: orcl Redo thread mounted by this instance: 1 Oracle process number: 24 Windows thread id: 4856, image: ORACLE.EXE (J000) *** 2025-06-14 22:06:30.890 *** SESSION ID:(193.15447) 2025-06-14 22:06:30.890 *** 2025-06-14 22:06:30.890 Process diagnostic dump for ORACLE.EXE (J000), OS id=4856, pid: 24, proc_ser: 232, sid: 193, sess_ser: 15447 ------------------------------------------------------------------------------- current sql: call dbms_stats.gather_database_stats_job_proc ( ) client details: O/S info: user: SYSTEM, term: WIN-3PIMCL4OH3L, ospid: 4856 machine: WIN-3PIMCL4OH3L program: ORACLE.EXE (J000) application name: DBMS_SCHEDULER, hash value=2478762354 action name: ORA$AT_OS_OPT_SY_12596, hash value=743287850 Current Wait Stack: Not in wait; last wait ended 0.998784 sec ago Wait State: fixed_waits=0 flags=0x21 boundary=0x0000000000000000/-1 Session Wait History: elapsed time of 0.998809 sec since last wait 0: waited for 'Disk file operations I/O' FileOperation=0x5, fileno=0x0, filetype=0x3 wait_id=166 seq_num=167 snap_id=1 wait times: snap=0.000231 sec, exc=0.000231 sec, total=0.000231 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000005 sec of elapsed time 1: waited for 'log file sequential read' log#=0x2861, block#=0x0, blocks=0x0 wait_id=165 seq_num=166 snap_id=1 wait times: snap=0.000006 sec, exc=0.000006 sec, total=0.000006 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.027065 sec of elapsed time 2: waited for 'log file sequential read' log#=0x2861, block#=0x0, blocks=0x0 wait_id=164 seq_num=165 snap_id=1 wait times: snap=0.000017 sec, exc=0.000017 sec, total=0.000017 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.175405 sec of elapsed time 3: waited for 'log file sequential read' log#=0x0, block#=0x6000, blocks=0x800 wait_id=163 seq_num=164 snap_id=1 wait times: snap=0.000282 sec, exc=0.000282 sec, total=0.000282 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 4: waited for 'log file sequential read' log#=0x0, block#=0x5800, blocks=0x800 wait_id=162 seq_num=163 snap_id=1 wait times: snap=0.000277 sec, exc=0.000277 sec, total=0.000277 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000004 sec of elapsed time 5: waited for 'log file sequential read' log#=0x0, block#=0x5000, blocks=0x800 wait_id=161 seq_num=162 snap_id=1 wait times: snap=0.000273 sec, exc=0.000273 sec, total=0.000273 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000041 sec of elapsed time 6: waited for 'log file sequential read' log#=0x0, block#=0x4800, blocks=0x800 wait_id=160 seq_num=161 snap_id=1 wait times: snap=0.000324 sec, exc=0.000324 sec, total=0.000324 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.352630 sec of elapsed time 7: waited for 'log file sequential read' log#=0x2861, block#=0x800, blocks=0x800 wait_id=159 seq_num=160 snap_id=1 wait times: snap=0.000197 sec, exc=0.000197 sec, total=0.000197 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.002704 sec of elapsed time 8: waited for 'log file sequential read' log#=0x2861, block#=0x0, blocks=0x0 wait_id=158 seq_num=159 snap_id=1 wait times: snap=0.000001 sec, exc=0.000001 sec, total=0.000001 sec wait times: max=infinite wait counts: calls=0 os=0 occurred after 0.000117 sec of elapsed time 9: waited for 'log file sequential read' log#=0x2861, block#=0x2, blocks=0x7fe wait_id=157 seq_num=158 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.000145 sec of elapsed time Sampled Session History of session 193 serial 15447 --------------------------------------------------- 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, 22:06:24 - 22:06:30] not in wait at each sample [12 samples, 22:06:11 - 22:06:23] idle wait at each sample [session created at: 22:06:11] ------------------------------------------------------------------------------- Process diagnostic dump actual duration=0.000000 sec (max dump time=30.000000 sec) *** 2025-06-14 22:06:30.890 ------------------------------------------------------------------------------- Trace Bucket Dump Begin: default bucket for process 24 (osid: 4856, J000) TIME(*=approx):SEQ:COMPONENT:FILE@LINE:FUNCTION:SECT/DUMP: [EVENT#:PID:SID] DATA ------------------------------------------------------------------------------- 2025-06-14 22:04:11.465929 :A4BE583A:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:ktcc.c:879 2025-06-14 22:04:11.465963 :A4BE583B:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:ktcc.c:879 2025-06-14 22:04:11.466252 :A4BE5841:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-14 22:04:11.466572 :A4BE5842:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-14 22:04:11.466685 :A4BE5843:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-14 22:04:11.466933 :A4BE5844: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-06-14 22:04:11.466970 :A4BE5847:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-14 22:04:11.468586 :A4BE584D:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-14 22:04:11.468814 :A4BE584E: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-06-14 22:04:11.468845 :A4BE5851:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-14 22:04:11.469729 :A4BE5857: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-06-14 22:04:11.469815 :A4BE585D: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-06-14 22:04:41.537061 :A4BE61CB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:04:42.299031 :A4BE621B:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:04:42.287 2025-06-14 22:04:42.299033 :A4BE621C:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12772 pso_num=24 pso_serial#=219 2025-06-14 22:04:42.299204 :A4BE621D:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12772 (legacy spawn) 2025-06-14 22:04:42.305751 :A4BE621E: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-06-14 22:04:42.305924 :A4BE6227: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-06-14 22:04:42.306735 :A4BE6228:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:04:44.600949 :A4BE62DF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:04:44.586 2025-06-14 22:04:44.600952 :A4BE62E0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17220 pso_num=24 pso_serial#=220 2025-06-14 22:04:44.601093 :A4BE62E1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17220 (legacy spawn) 2025-06-14 22:04:44.607863 :A4BE62E2: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-06-14 22:04:44.608060 :A4BE62EB: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-06-14 22:04:44.608980 :A4BE62EC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:04:44.618266 :A4BE62EF:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:04:44.617 2025-06-14 22:04:44.618269 :A4BE62F0:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12128 pso_num=24 pso_serial#=221 2025-06-14 22:04:44.618419 :A4BE62F1:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12128 (legacy spawn) 2025-06-14 22:04:44.625027 :A4BE62F2: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-06-14 22:04:44.625200 :A4BE62FB: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-06-14 22:04:44.626073 :A4BE62FC:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:04:47.708602 :A4BE63F5:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:04:47.695 2025-06-14 22:04:47.708605 :A4BE63F6:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17136 pso_num=24 pso_serial#=222 2025-06-14 22:04:47.708742 :A4BE63F7:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17136 (legacy spawn) 2025-06-14 22:04:47.714880 :A4BE641B: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-06-14 22:04:47.715055 :A4BE6424: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-06-14 22:04:47.715854 :A4BE6425:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:04:47.724512 :A4BE6428:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:04:47.711 2025-06-14 22:04:47.724514 :A4BE6429:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17168 pso_num=24 pso_serial#=223 2025-06-14 22:04:47.724655 :A4BE642A:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17168 (legacy spawn) 2025-06-14 22:04:47.731169 :A4BE642B: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-06-14 22:04:47.731334 :A4BE6434: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-06-14 22:04:47.732143 :A4BE6435:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:04:57.404328 :A4BE6723:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:04:57.396 2025-06-14 22:04:57.404330 :A4BE6724:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=13360 pso_num=24 pso_serial#=224 2025-06-14 22:04:57.404470 :A4BE6725:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=13360 (legacy spawn) 2025-06-14 22:04:57.411026 :A4BE6726: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-06-14 22:04:57.411202 :A4BE672D: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-06-14 22:04:57.412037 :A4BE6730:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:05:11.457169 :A4BE6BB8:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:05:11.451 2025-06-14 22:05:11.457171 :A4BE6BB9:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15856 pso_num=24 pso_serial#=225 2025-06-14 22:05:11.457325 :A4BE6BBA:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=15856 osp_idx=22 osp_ver=407479 osp_pg=0 (spawn #285833) 2025-06-14 22:05:11.457326 :A4BE6BBB:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 22:05:11.457326 :A4BE6BBC:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=85 time=2914454641 2025-06-14 22:05:11.457327 :A4BE6BBD:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 22:05:11.457327 :A4BE6BBE:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 22:05:11.457328 :A4BE6BBF:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 22:05:11.457328 :A4BE6BC0:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 22:05:11.457328 :A4BE6BC1:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 22:05:11.457866 :A4BE6BC2: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-06-14 22:05:11.458560 :A4BE6BD7: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-06-14 22:05:11.466307 :A4BE6BF3:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-14 22:05:11.466788 :A4BE6BF4: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-06-14 22:05:11.466828 :A4BE6BF7:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-14 22:05:11.467730 :A4BE6BFD: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-06-14 22:05:11.467854 :A4BE6C06: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-06-14 22:05:41.554357 :A4BE7C84:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:05:50.055538 :A4BE7F44:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:05:50.042 2025-06-14 22:05:50.055540 :A4BE7F45:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12820 pso_num=24 pso_serial#=226 2025-06-14 22:05:50.055685 :A4BE7F46:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12820 (legacy spawn) 2025-06-14 22:05:50.062298 :A4BE7F47: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-06-14 22:05:50.062474 :A4BE7F4C: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-06-14 22:05:50.063306 :A4BE7F51:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:05:57.091222 :A4BE81AE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:05:57.077 2025-06-14 22:05:57.091224 :A4BE81AF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=16636 pso_num=24 pso_serial#=227 2025-06-14 22:05:57.091363 :A4BE81B0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=16636 (legacy spawn) 2025-06-14 22:05:57.097878 :A4BE81B1: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-06-14 22:05:57.098043 :A4BE81BA: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-06-14 22:05:57.098866 :A4BE81BB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:05:57.116360 :A4BE81BE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:05:57.108 2025-06-14 22:05:57.116362 :A4BE81BF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=15772 pso_num=24 pso_serial#=228 2025-06-14 22:05:57.116502 :A4BE81C0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=15772 (legacy spawn) 2025-06-14 22:05:57.122966 :A4BE81C1: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-06-14 22:05:57.123129 :A4BE81CA: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-06-14 22:05:57.124003 :A4BE81CB:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:05:59.556012 :A4BE8261:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:05:59.548 2025-06-14 22:05:59.556014 :A4BE8262:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=14460 pso_num=24 pso_serial#=229 2025-06-14 22:05:59.556152 :A4BE8263:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=14460 (legacy spawn) 2025-06-14 22:05:59.562610 :A4BE8264: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-06-14 22:05:59.562780 :A4BE8269: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-06-14 22:05:59.563631 :A4BE826E:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:06:00.295694 :A4BE82BE:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:06:00.282 2025-06-14 22:06:00.295696 :A4BE82BF:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=17144 pso_num=24 pso_serial#=230 2025-06-14 22:06:00.295862 :A4BE82C0:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=17144 (legacy spawn) 2025-06-14 22:06:00.302344 :A4BE82C1: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-06-14 22:06:00.302374 :A4BE82C4: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-06-14 22:06:00.302521 :A4BE82C8: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-06-14 22:06:00.303353 :A4BE82D7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:06:00.312011 :A4BE82DA:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:06:00.298 2025-06-14 22:06:00.312013 :A4BE82DB:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=12944 pso_num=24 pso_serial#=231 2025-06-14 22:06:00.312147 :A4BE82DC:db_trace:kso.c@4070:ksonfy(): [10420:24:0] kso: new process: pid=12944 (legacy spawn) 2025-06-14 22:06:00.318601 :A4BE82DD: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-06-14 22:06:00.318765 :A4BE82E6: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-06-14 22:06:00.319552 :A4BE82E7:db_trace:kst.c@698:kstpsodel(): [10280:24:0] kst: process state object about to be deleted 2025-06-14 22:06:11.547055 :A4BE8671:db_trace:kst.c@673:kstipg(): [10280:24:0] kst: process state object created on 06-14 22:06:11.541 2025-06-14 22:06:11.547057 :A4BE8672:db_trace:kst.c@679:kstipg(): [10280:24:0] kst: process info: ospid=4856 pso_num=24 pso_serial#=232 2025-06-14 22:06:11.547204 :A4BE8673:db_trace:kso.c@4093:ksonfy(): [10420:24:0] kso: new process: pid=4856 osp_idx=22 osp_ver=407486 osp_pg=0 (spawn #285835) 2025-06-14 22:06:11.547205 :A4BE8674:db_trace:kso.c@4099:ksonfy(): [10420:24:0] kso: new process: first_req_pid=4308 spawner_pid=3660 sga_crt_ts=x8A8A 2025-06-14 22:06:11.547205 :A4BE8675:db_trace:kso.c@4103:ksonfy(): [10420:24:0] kso: new process: pso_index=24 reservation=86 time=2914514735 2025-06-14 22:06:11.547206 :A4BE8676:db_trace:kso.c@4109:ksonfy(): [10420:24:0] kso: spawn diagnostics: queue time=0 secs 2025-06-14 22:06:11.547206 :A4BE8677:db_trace:kso.c@4111:ksonfy(): [10420:24:0] kso: spawn diagnostics: fork time=0 secs 2025-06-14 22:06:11.547206 :A4BE8678:db_trace:kso.c@4113:ksonfy(): [10420:24:0] kso: spawn diagnostics: exec time=0 secs 2025-06-14 22:06:11.547207 :A4BE8679:db_trace:kso.c@4115:ksonfy(): [10420:24:0] kso: spawn diagnostics: pre dbkc time=0 secs 2025-06-14 22:06:11.547207 :A4BE867A:db_trace:kso.c@4117:ksonfy(): [10420:24:0] kso: spawn diagnostics: post dbkc time=0 secs 2025-06-14 22:06:11.547725 :A4BE867B: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-06-14 22:06:11.548417 :A4BE8690: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-06-14 22:06:11.559691 :A4BE86AC:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-14 22:06:11.560184 :A4BE86AD:db_trace:kwqid.c@2146:kwqidrdq(): [10960:24:193] kwqidrdq: Error: 1403 occured in OCI execute 2025-06-14 22:06:11.562556 :A4BE86AE:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-14 22:06:11.562924 :A4BE86AF: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-06-14 22:06:11.562963 :A4BE86B2:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-14 22:06:11.563917 :A4BE86B8: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-06-14 22:06:11.564053 :A4BE86C1: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-06-14 22:06:24.011437 :A4BE8BBB: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-06-14 22:06:24.011437*:A4BE8BBD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000024D5C718 estart=1749909983 eid=16782341 ctx=0x000000077FD6A000 cwh=0x0000000024D50068 cpu=0 buffg=1 interb=0 r=0 rb=0 w=0 wb=0 2025-06-14 22:06:24.011437*:A4BE8BBE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 pubTabIdxCnt=0 2025-06-14 22:06:24.011437*:A4BE8BBF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000024D5C718 2025-06-14 22:06:24.011437*:A4BE8BC0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000024D5C718 2025-06-14 22:06:24.011437*:A4BE8BC1:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000024D5C718 curCtx=0x0000000024D58938 xsc->flg4=65792 flags=2 2025-06-14 22:06:24.011437*:A4BE8BC2:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000024D5C718 2025-06-14 22:06:24.013253 :A4BE8BC3: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-06-14 22:06:24.013289 :A4BE8BC6:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:jslv.c:9203 2025-06-14 22:06:24.031579 :A4BE8C09: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-06-14 22:06:24.031791 :A4BE8C11: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-06-14 22:06:24.031954 :A4BE8C19: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-06-14 22:06:24.032131 :A4BE8C21: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-06-14 22:06:24.032291 :A4BE8C29: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-06-14 22:06:24.032606 :A4BE8C31: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-06-14 22:06:24.032858 :A4BE8C39: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-06-14 22:06:24.033172 :A4BE8C41: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-06-14 22:06:24.033325 :A4BE8C49: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-06-14 22:06:24.033520 :A4BE8C51: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-06-14 22:06:24.033694 :A4BE8C59: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-06-14 22:06:24.033842 :A4BE8C63: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-06-14 22:06:24.034006 :A4BE8C6C: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-06-14 22:06:24.034156 :A4BE8C74: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-06-14 22:06:24.034304 :A4BE8C7C: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-06-14 22:06:24.034447 :A4BE8C84: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-06-14 22:06:24.034604 :A4BE8C8C: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-06-14 22:06:24.040758 :A4BE8C97:db_trace:ksl2.c@14083:ksl_update_post_stats(): [10005:24:193] 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 22:06:24.052942 :A4BE8CA3: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-06-14 22:06:25.918317 :A4BE8E8E: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-06-14 22:06:25.940407 :A4BE8E96: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-06-14 22:06:25.942613 :A4BE8E9E:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpus:psdpgi.c:2235 2025-06-14 22:06:25.942834 :A4BE8E9F:db_trace:ktc.c@8711:ktcAutoTxnTrace(): [10441:24:193] atxpop:psdpgi.c:2235 2025-06-14 22:06:25.943789 :A4BE8EA0: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-06-14 22:06:25.943898 :A4BE8EA3: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-06-14 22:06:25.944914 :A4BE8EB5: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-06-14 22:06:25.946636 :A4BE8EBD: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-06-14 22:06:25.946944 :A4BE8EC5: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-06-14 22:06:25.978684*:A4BE8ECD:sql_mon_query:keswx.c@6099:keswxCurPushMonitoring(begin): xsc=0x0000000029B20B90 estart=1749909984 eid=16777855 ctx=0x000000079F4EAD08 cwh=0x0000000029272138 cpu=15625 buffg=0 interb=0 r=0 rb=0 w=0 wb=0 2025-06-14 22:06:25.978684*:A4BE8ECE:sql_mon_query:keswx.c@2839:keswxCurPrepare(): Allocate monitor context: xsc=0x0000000029B20B90 curCtx=0x0000000029B13300 pubTabIdxCnt=0 2025-06-14 22:06:25.978684*:A4BE8ECF:sql_mon_query:keswx.c@6131:keswxCurPushMonitoring(): clear monitoring flag for xsc=0x0000000029B20B90 2025-06-14 22:06:25.978684*:A4BE8ED0:sql_mon_query:keswx.c@6263:keswxCurPushMonitoring(end): full monitoring not yet started for xsc=0x0000000029B20B90 2025-06-14 22:06:25.978684*:A4BE8ED1:sql_mon_query:keswx.c@3282:keswxCurEndPlanMonitoringCb(begin): xsc=0x0000000029B20B90 curCtx=0x0000000029B13300 xsc->flg4=65792 flags=1 2025-06-14 22:06:25.978684*:A4BE8ED2:sql_mon_query:keswx.c@3389:keswxCurEndPlanMonitoringCb(end): monitoring has ended for xsc=0x0000000029B20B90 2025-06-14 22:06:25.994306*: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 22:06:25.994306*:SQL_Analyze:qksan.c@936:qksanBindSql(begin): binding for SQL analyze 2025-06-14 22:06:25.994306*:SQL_Analyze:qksan.c@1344:qksanBindSql(end): Done binding: status=0 ret=0 bind#=0 byPos=1 wasBoundP=0x0000000000000000 bindIndP=0x0000000000000000 2025-06-14 22:06:25.994306*:SQL_Analyze:qksan.c@6338:qksanAvgExecStats(): The number of total executions: 1 and execution count: 0 2025-06-14 22:06:25.994306*:SQL_Analyze:qksan.c@4776:qksanPostAnalyzeDump(begin): qksanPostAnalyzeDump(): Dumping analyze context after compilation qksanStatus=SUCCESS ecode=0 2025-06-14 22:06:25.994306*:SQL_Analyze:qksan.c@4800:qksanPostAnalyzeDump(end): 2025-06-14 22:06:25.994306*:SQL_Analyze:qksan.c@3690:qksanAnalyzeSql(end): exit: ecode=0 status=0 2025-06-14 22:06:26.077719 :A4BE8EDF: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-06-14 22:06:27.967945 :A4BE8F7A: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-06-14 22:06:27.967959 :A4BE8F7B:db_trace:ktur.c@3079:ktuabt(): [10444:24:193] ABORT TRANSACTION - xid: 0x000a.00f.0016e087 2025-06-14 22:06:30.368143 :A4BE9135: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-06-14 22:06:30.372633 :A4BE913D: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-06-14 22:06:30.383926 :A4BE9145: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-06-14 22:06:30.409540 :A4BE914D: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 ------------------------------------------------------------------------------- Trace Bucket Dump End: default bucket for process 24 (osid: 4856, J000)
Ms-Dos/Windows
Unix
Write backup
jsp File Browser version 1.2 by
www.vonloesch.de